builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-033 starttime: 1457309790.28 results: success (0) buildid: 20160306135809 builduid: 595a19db193b4aa99e70424824dca01e revision: d6e19d0079ea3c0d04cdac5824a0675cbf3800c5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-06 16:16:30.277264) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-06 16:16:30.277676) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-06 16:16:30.278055) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1457302193.275829-704462114 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.008837 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-06 16:16:30.308777) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-06 16:16:30.309117) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-06 16:16:30.351345) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 16:16:30.351646) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1457302193.275829-704462114 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.044619 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 16:16:30.410723) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-06 16:16:30.411015) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-06 16:16:30.411371) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 16:16:30.411709) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1457302193.275829-704462114 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-06 16:16:30-- 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% 37.9M=0s 2016-03-06 16:16:30 (37.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.500792 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 16:16:30.928441) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 16:16:30.929179) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1457302193.275829-704462114 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.154534 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 16:16:31.098587) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 16:16:31.099402) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d6e19d0079ea3c0d04cdac5824a0675cbf3800c5 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d6e19d0079ea3c0d04cdac5824a0675cbf3800c5 --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=edae0fb5fee9fb758e8af6d3000002a4-1457302193.275829-704462114 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-06 16:16:31,195 truncating revision to first 12 chars 2016-03-06 16:16:31,195 Setting DEBUG logging. 2016-03-06 16:16:31,195 attempt 1/10 2016-03-06 16:16:31,195 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d6e19d0079ea?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-06 16:16:31,472 unpacking tar archive at: mozilla-aurora-d6e19d0079ea/testing/mozharness/ program finished with exit code 0 elapsedTime=0.609205 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 16:16:31.724507) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-06 16:16:31.725277) ========= echo d6e19d0079ea3c0d04cdac5824a0675cbf3800c5 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd6e19d0079ea3c0d04cdac5824a0675cbf3800c5'] 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=edae0fb5fee9fb758e8af6d3000002a4-1457302193.275829-704462114 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False d6e19d0079ea3c0d04cdac5824a0675cbf3800c5 program finished with exit code 0 elapsedTime=0.004751 script_repo_revision: 'd6e19d0079ea3c0d04cdac5824a0675cbf3800c5' ========= master_lag: 0.06 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-06 16:16:31.786085) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-06 16:16:31.786390) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-06 16:16:31.796150) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 47 secs) (at 2016-03-06 16:16:31.796467) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=edae0fb5fee9fb758e8af6d3000002a4-1457302193.275829-704462114 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:16:32 INFO - MultiFileLogger online at 20160306 16:16:32 in /builds/slave/test-pgo 16:16:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 16:16:32 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:16:32 INFO - {'append_to_log': False, 16:16:32 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:16:32 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:16:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:16:32 INFO - 'branch': 'Mozilla-Aurora', 16:16:32 INFO - 'buildbot_json_path': 'buildprops.json', 16:16:32 INFO - 'config_files': ('talos/linux_config.py',), 16:16:32 INFO - 'default_actions': ('clobber', 16:16:32 INFO - 'read-buildbot-config', 16:16:32 INFO - 'download-and-extract', 16:16:32 INFO - 'populate-webroot', 16:16:32 INFO - 'create-virtualenv', 16:16:32 INFO - 'install', 16:16:32 INFO - 'run-tests'), 16:16:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:16:32 INFO - 'download_minidump_stackwalk': True, 16:16:32 INFO - 'download_symbols': 'ondemand', 16:16:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:16:32 INFO - 'tooltool.py': '/tools/tooltool.py', 16:16:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:16:32 INFO - '/tools/misc-python/virtualenv.py')}, 16:16:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:16:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:16:32 INFO - 'installer_path': 'installer.exe', 16:16:32 INFO - 'log_level': 'info', 16:16:32 INFO - 'log_name': 'talos', 16:16:32 INFO - 'log_to_console': True, 16:16:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:16:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:16:32 INFO - 'opt_config_files': (), 16:16:32 INFO - 'pip_index': False, 16:16:32 INFO - 'sps_profile': False, 16:16:32 INFO - 'sps_profile_interval': 0, 16:16:32 INFO - 'suite': 'dromaeojs-e10s', 16:16:32 INFO - 'system_bits': '32', 16:16:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:16:32 INFO - 'title': 'talos-linux64-ix-033', 16:16:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:16:32 INFO - 'use_talos_json': True, 16:16:32 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:16:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:16:32 INFO - 'work_dir': 'build'} 16:16:32 INFO - ##### 16:16:32 INFO - ##### Running clobber step. 16:16:32 INFO - ##### 16:16:32 INFO - Running pre-action listener: _resource_record_pre_action 16:16:32 INFO - Running main action method: clobber 16:16:32 INFO - rmtree: /builds/slave/test-pgo/build 16:16:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:16:33 INFO - Running post-action listener: _resource_record_post_action 16:16:33 INFO - ##### 16:16:33 INFO - ##### Running read-buildbot-config step. 16:16:33 INFO - ##### 16:16:33 INFO - Running pre-action listener: _resource_record_pre_action 16:16:33 INFO - Running main action method: read_buildbot_config 16:16:33 INFO - Using buildbot properties: 16:16:33 INFO - { 16:16:33 INFO - "project": "", 16:16:33 INFO - "product": "firefox", 16:16:33 INFO - "script_repo_revision": "production", 16:16:33 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 16:16:33 INFO - "repository": "", 16:16:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 16:16:33 INFO - "buildid": "20160306135809", 16:16:33 INFO - "pgo_build": "True", 16:16:33 INFO - "basedir": "/builds/slave/test-pgo", 16:16:33 INFO - "buildnumber": 212, 16:16:33 INFO - "slavename": "talos-linux64-ix-033", 16:16:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:16:33 INFO - "platform": "ubuntu64_hw", 16:16:33 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 16:16:33 INFO - "branch": "mozilla-aurora", 16:16:33 INFO - "repo_path": "releases/mozilla-aurora", 16:16:33 INFO - "revision": "d6e19d0079ea3c0d04cdac5824a0675cbf3800c5", 16:16:33 INFO - "stage_platform": "linux64-pgo", 16:16:33 INFO - "builduid": "595a19db193b4aa99e70424824dca01e", 16:16:33 INFO - "slavebuilddir": "test" 16:16:33 INFO - } 16:16:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/T1cLqKpcRTCvibduD1IYww/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2. 16:16:33 INFO - Running post-action listener: _resource_record_post_action 16:16:33 INFO - ##### 16:16:33 INFO - ##### Running download-and-extract step. 16:16:33 INFO - ##### 16:16:33 INFO - Running pre-action listener: _resource_record_pre_action 16:16:33 INFO - Running main action method: download_and_extract 16:16:33 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:16:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:33 INFO - https://queue.taskcluster.net/v1/task/T1cLqKpcRTCvibduD1IYww/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:16:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T1cLqKpcRTCvibduD1IYww/artifacts/public/build/test_packages.json 16:16:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T1cLqKpcRTCvibduD1IYww/artifacts/public/build/test_packages.json 16:16:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T1cLqKpcRTCvibduD1IYww/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:16:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T1cLqKpcRTCvibduD1IYww/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:16:34 INFO - Downloaded 1448 bytes. 16:16:34 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:16:34 INFO - Using the following test package requirements: 16:16:34 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 16:16:34 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 16:16:34 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 16:16:34 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 16:16:34 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 16:16:34 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 16:16:34 INFO - u'jsshell-linux-x86_64.zip'], 16:16:34 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 16:16:34 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 16:16:34 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 16:16:34 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 16:16:34 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 16:16:34 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 16:16:34 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 16:16:34 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 16:16:34 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 16:16:34 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 16:16:34 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 16:16:34 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 16:16:34 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:16: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')]} 16:16:34 INFO - https://queue.taskcluster.net/v1/task/T1cLqKpcRTCvibduD1IYww/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:16:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T1cLqKpcRTCvibduD1IYww/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 16:16:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T1cLqKpcRTCvibduD1IYww/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 16:16:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T1cLqKpcRTCvibduD1IYww/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 16:16:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T1cLqKpcRTCvibduD1IYww/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:16:35 INFO - Downloaded 23098397 bytes. 16:16:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 16:16:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 16:16:36 INFO - Return code: 0 16:16:36 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:36 INFO - https://queue.taskcluster.net/v1/task/T1cLqKpcRTCvibduD1IYww/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:16:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T1cLqKpcRTCvibduD1IYww/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 16:16:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T1cLqKpcRTCvibduD1IYww/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 16:16:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T1cLqKpcRTCvibduD1IYww/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 16:16:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T1cLqKpcRTCvibduD1IYww/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:16:38 INFO - Downloaded 23098397 bytes. 16:16:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 16:16:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 16:16:43 INFO - Return code: 0 16:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:43 INFO - https://queue.taskcluster.net/v1/task/T1cLqKpcRTCvibduD1IYww/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:16:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T1cLqKpcRTCvibduD1IYww/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 16:16:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T1cLqKpcRTCvibduD1IYww/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 16:16:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T1cLqKpcRTCvibduD1IYww/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 16:16:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T1cLqKpcRTCvibduD1IYww/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:16:44 INFO - Downloaded 10801536 bytes. 16:16:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 16:16:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 16:16:44 INFO - Return code: 0 16:16:44 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')]} 16:16:44 INFO - https://queue.taskcluster.net/v1/task/T1cLqKpcRTCvibduD1IYww/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:16:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T1cLqKpcRTCvibduD1IYww/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 16:16:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T1cLqKpcRTCvibduD1IYww/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 16:16:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T1cLqKpcRTCvibduD1IYww/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 16:16:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T1cLqKpcRTCvibduD1IYww/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:16:46 INFO - Downloaded 59965674 bytes. 16:16:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T1cLqKpcRTCvibduD1IYww/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 16:16:46 INFO - mkdir: /builds/slave/test-pgo/properties 16:16:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:16:46 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:16:46 INFO - Contents: 16:16:46 INFO - build_url:https://queue.taskcluster.net/v1/task/T1cLqKpcRTCvibduD1IYww/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 16:16:46 INFO - Running post-action listener: _resource_record_post_action 16:16:46 INFO - Running post-action listener: set_extra_try_arguments 16:16:46 INFO - ##### 16:16:46 INFO - ##### Running populate-webroot step. 16:16:46 INFO - ##### 16:16:46 INFO - Running pre-action listener: _resource_record_pre_action 16:16:46 INFO - Running main action method: populate_webroot 16:16:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:16:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:16:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:16:46 INFO - '--tppagecycles', 16:16:46 INFO - '7'], 16:16:46 INFO - 'tests': ['tsvgm']}}, 16:16:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:16:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:16:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:16:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:16:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:16:46 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:16:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:16:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:46 INFO - 'talos_options': ['--e10s'], 16:16:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:16:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:46 INFO - 'tests': ['damp', 'tps']}, 16:16:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:46 INFO - 'talos_options': ['--e10s'], 16:16:46 INFO - 'tests': ['damp', 'tps']}, 16:16:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:16:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:16:46 INFO - 'other': {'tests': ['a11yr', 16:16:46 INFO - 'ts_paint', 16:16:46 INFO - 'tpaint', 16:16:46 INFO - 'sessionrestore', 16:16:46 INFO - 'sessionrestore_no_auto_restore']}, 16:16:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:16:46 INFO - 'tests': ['a11yr', 16:16:46 INFO - 'ts_paint', 16:16:46 INFO - 'tpaint', 16:16:46 INFO - 'sessionrestore', 16:16:46 INFO - 'sessionrestore_no_auto_restore']}, 16:16:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:16:46 INFO - 'tests': ['a11yr', 16:16:46 INFO - 'ts_paint', 16:16:46 INFO - 'tpaint', 16:16:46 INFO - 'sessionrestore', 16:16:46 INFO - 'sessionrestore_no_auto_restore']}, 16:16:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:16:46 INFO - 'tests': ['a11yr', 16:16:46 INFO - 'ts_paint', 16:16:46 INFO - 'tpaint', 16:16:46 INFO - 'sessionrestore', 16:16:46 INFO - 'sessionrestore_no_auto_restore']}, 16:16:46 INFO - 'other_l64': {'tests': ['a11yr', 16:16:46 INFO - 'ts_paint', 16:16:46 INFO - 'tpaint', 16:16:46 INFO - 'sessionrestore', 16:16:46 INFO - 'sessionrestore_no_auto_restore']}, 16:16:46 INFO - 'other_nol64': {'tests': ['a11yr', 16:16:46 INFO - 'ts_paint', 16:16:46 INFO - 'tpaint', 16:16:46 INFO - 'sessionrestore', 16:16:46 INFO - 'sessionrestore_no_auto_restore']}, 16:16:46 INFO - 'svgr': {'tests': ['tsvgx', 16:16:46 INFO - 'tsvgr_opacity', 16:16:46 INFO - 'tart', 16:16:46 INFO - 'tscrollx', 16:16:46 INFO - 'cart']}, 16:16:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:16:46 INFO - 'tests': ['tsvgx', 16:16:46 INFO - 'tsvgr_opacity', 16:16:46 INFO - 'tart', 16:16:46 INFO - 'tscrollx', 16:16:46 INFO - 'cart']}, 16:16:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:46 INFO - 'tests': ['tp5o']}, 16:16:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:46 INFO - 'talos_options': ['--e10s'], 16:16:46 INFO - 'tests': ['tp5o']}, 16:16:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:46 INFO - 'talos_options': ['--xperf_path', 16:16:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:16:46 INFO - 'tests': ['tp5n']}, 16:16:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:46 INFO - 'talos_options': ['--e10s', 16:16:46 INFO - '--xperf_path', 16:16:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:16:46 INFO - 'tests': ['tp5n']}}, 16:16:46 INFO - 'talos.zip': {'path': '', 16:16:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:16:46 INFO - Running post-action listener: _resource_record_post_action 16:16:46 INFO - ##### 16:16:46 INFO - ##### Running create-virtualenv step. 16:16:46 INFO - ##### 16:16:46 INFO - Running pre-action listener: _resource_record_pre_action 16:16:46 INFO - Running main action method: create_virtualenv 16:16:46 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:16:46 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 16:16:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:16:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:16:47 INFO - Using real prefix '/usr' 16:16:47 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:16:47 INFO - Installing distribute.............................................................................................................................................................................................done. 16:16:49 INFO - Installing pip.................done. 16:16:49 INFO - Return code: 0 16:16:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf7e648f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe08290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9a850>, '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 0xe06330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe067c0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1457302193.275829-704462114', '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 16:16:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 16:16:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:16:49 INFO - Using env: {'DISPLAY': ':0', 16:16:49 INFO - 'HOME': '/home/cltbld', 16:16:49 INFO - 'LANG': 'en_US.UTF-8', 16:16:49 INFO - 'LANGUAGE': 'en_US:en', 16:16:49 INFO - 'LOGNAME': 'cltbld', 16:16:49 INFO - 'MAIL': '/var/mail/cltbld', 16:16:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:49 INFO - 'MOZ_NO_REMOTE': '1', 16:16:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:49 INFO - 'NO_EM_RESTART': '1', 16:16:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:16:49 INFO - 'PWD': '/builds/slave/test-pgo', 16:16:49 INFO - 'SHELL': '/bin/bash', 16:16:49 INFO - 'SHLVL': '1', 16:16:49 INFO - 'TERM': 'linux', 16:16:49 INFO - 'TMOUT': '86400', 16:16:49 INFO - 'USER': 'cltbld', 16:16:49 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1457302193.275829-704462114', 16:16:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:49 INFO - '_': '/tools/buildbot/bin/python'} 16:16:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:49 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 16:16:49 INFO - Cleaning up... 16:16:49 INFO - Return code: 0 16:16:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbf7e648f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe08290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9a850>, '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 0xe06330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe067c0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1457302193.275829-704462114', '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 16:16:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 16:16:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:16:49 INFO - Using env: {'DISPLAY': ':0', 16:16:49 INFO - 'HOME': '/home/cltbld', 16:16:49 INFO - 'LANG': 'en_US.UTF-8', 16:16:49 INFO - 'LANGUAGE': 'en_US:en', 16:16:49 INFO - 'LOGNAME': 'cltbld', 16:16:49 INFO - 'MAIL': '/var/mail/cltbld', 16:16:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:49 INFO - 'MOZ_NO_REMOTE': '1', 16:16:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:49 INFO - 'NO_EM_RESTART': '1', 16:16:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:16:49 INFO - 'PWD': '/builds/slave/test-pgo', 16:16:49 INFO - 'SHELL': '/bin/bash', 16:16:49 INFO - 'SHLVL': '1', 16:16:49 INFO - 'TERM': 'linux', 16:16:49 INFO - 'TMOUT': '86400', 16:16:49 INFO - 'USER': 'cltbld', 16:16:49 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1457302193.275829-704462114', 16:16:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:49 INFO - '_': '/tools/buildbot/bin/python'} 16:16:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:49 INFO - Downloading/unpacking psutil>=0.7.1 16:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:16:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:16:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:16:51 INFO - Installing collected packages: psutil 16:16:51 INFO - Running setup.py install for psutil 16:16:51 INFO - building 'psutil._psutil_linux' extension 16:16:51 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 16:16:52 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 16:16:52 INFO - building 'psutil._psutil_posix' extension 16:16:52 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 16:16:52 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 16:16:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:16:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:16:52 INFO - Successfully installed psutil 16:16:52 INFO - Cleaning up... 16:16:52 INFO - Return code: 0 16:16:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:16: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')]} 16:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16: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')]} 16:16:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbf7e648f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe08290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9a850>, '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 0xe06330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe067c0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1457302193.275829-704462114', '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 16:16:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 16:16:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:16:52 INFO - Using env: {'DISPLAY': ':0', 16:16:52 INFO - 'HOME': '/home/cltbld', 16:16:52 INFO - 'LANG': 'en_US.UTF-8', 16:16:52 INFO - 'LANGUAGE': 'en_US:en', 16:16:52 INFO - 'LOGNAME': 'cltbld', 16:16:52 INFO - 'MAIL': '/var/mail/cltbld', 16:16:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:52 INFO - 'MOZ_NO_REMOTE': '1', 16:16:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:52 INFO - 'NO_EM_RESTART': '1', 16:16:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:16:52 INFO - 'PWD': '/builds/slave/test-pgo', 16:16:52 INFO - 'SHELL': '/bin/bash', 16:16:52 INFO - 'SHLVL': '1', 16:16:52 INFO - 'TERM': 'linux', 16:16:52 INFO - 'TMOUT': '86400', 16:16:52 INFO - 'USER': 'cltbld', 16:16:52 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1457302193.275829-704462114', 16:16:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:52 INFO - '_': '/tools/buildbot/bin/python'} 16:16:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:16: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 16:16: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 16:16: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 16:16: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 16:16: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 16:16: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 16:16:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:16:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:16:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:16:54 INFO - Installing collected packages: mozsystemmonitor 16:16:54 INFO - Running setup.py install for mozsystemmonitor 16:16:54 INFO - Successfully installed mozsystemmonitor 16:16:54 INFO - Cleaning up... 16:16:54 INFO - Return code: 0 16:16:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:16:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf7e648f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe08290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9a850>, '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 0xe06330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe067c0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1457302193.275829-704462114', '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 16:16:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 16:16:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:16:54 INFO - Using env: {'DISPLAY': ':0', 16:16:54 INFO - 'HOME': '/home/cltbld', 16:16:54 INFO - 'LANG': 'en_US.UTF-8', 16:16:54 INFO - 'LANGUAGE': 'en_US:en', 16:16:54 INFO - 'LOGNAME': 'cltbld', 16:16:54 INFO - 'MAIL': '/var/mail/cltbld', 16:16:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:54 INFO - 'MOZ_NO_REMOTE': '1', 16:16:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:54 INFO - 'NO_EM_RESTART': '1', 16:16:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:16:54 INFO - 'PWD': '/builds/slave/test-pgo', 16:16:54 INFO - 'SHELL': '/bin/bash', 16:16:54 INFO - 'SHLVL': '1', 16:16:54 INFO - 'TERM': 'linux', 16:16:54 INFO - 'TMOUT': '86400', 16:16:54 INFO - 'USER': 'cltbld', 16:16:54 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1457302193.275829-704462114', 16:16:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:54 INFO - '_': '/tools/buildbot/bin/python'} 16:16:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:54 INFO - Downloading/unpacking blobuploader==1.2.4 16:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:56 INFO - Downloading blobuploader-1.2.4.tar.gz 16:16:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:16:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:16:56 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 16:16:56 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 16:16:56 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 16:16:56 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 16:16:56 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 16:16:56 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 16:16:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:16:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:16: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 16:16: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 16:16: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 16:16: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 16:16: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 16:16: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 16:16:57 INFO - Downloading docopt-0.6.1.tar.gz 16:16:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:16:57 INFO - Installing collected packages: blobuploader, requests, docopt 16:16:57 INFO - Running setup.py install for blobuploader 16:16:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:16:57 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:16:57 INFO - Running setup.py install for requests 16:16:57 INFO - Running setup.py install for docopt 16:16:57 INFO - Successfully installed blobuploader requests docopt 16:16:57 INFO - Cleaning up... 16:16:57 INFO - Return code: 0 16:16:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:16: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')]} 16:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16: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')]} 16:16:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf7e648f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe08290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9a850>, '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 0xe06330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe067c0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1457302193.275829-704462114', '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 16:16:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 16:16:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:16:57 INFO - Using env: {'DISPLAY': ':0', 16:16:57 INFO - 'HOME': '/home/cltbld', 16:16:57 INFO - 'LANG': 'en_US.UTF-8', 16:16:57 INFO - 'LANGUAGE': 'en_US:en', 16:16:57 INFO - 'LOGNAME': 'cltbld', 16:16:57 INFO - 'MAIL': '/var/mail/cltbld', 16:16:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:57 INFO - 'MOZ_NO_REMOTE': '1', 16:16:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:57 INFO - 'NO_EM_RESTART': '1', 16:16:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:16:57 INFO - 'PWD': '/builds/slave/test-pgo', 16:16:57 INFO - 'SHELL': '/bin/bash', 16:16:57 INFO - 'SHLVL': '1', 16:16:57 INFO - 'TERM': 'linux', 16:16:57 INFO - 'TMOUT': '86400', 16:16:57 INFO - 'USER': 'cltbld', 16:16:57 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1457302193.275829-704462114', 16:16:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:57 INFO - '_': '/tools/buildbot/bin/python'} 16:16:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:16:58 INFO - Running setup.py (path:/tmp/pip-5WCK05-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:16:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:16:58 INFO - Running setup.py (path:/tmp/pip-twFd5e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:16:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:16:58 INFO - Running setup.py (path:/tmp/pip-La3o_B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:16:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:16:58 INFO - Running setup.py (path:/tmp/pip-gVBRW3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:16:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:16:58 INFO - Running setup.py (path:/tmp/pip-xnvGn7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:16:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:16:58 INFO - Running setup.py (path:/tmp/pip-vKn6mc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:16:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:16:58 INFO - Running setup.py (path:/tmp/pip-aDcbD4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:16:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:16:58 INFO - Running setup.py (path:/tmp/pip-LULj5L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:16:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:16:58 INFO - Running setup.py (path:/tmp/pip-1czWkg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:16:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:16:58 INFO - Running setup.py (path:/tmp/pip-XwZ6Yp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:16:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:16:58 INFO - Running setup.py (path:/tmp/pip-N95GKs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:16:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:16:58 INFO - Running setup.py (path:/tmp/pip-kA2JKK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:16:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:16:59 INFO - Running setup.py (path:/tmp/pip-WjYgb6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:16:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:16:59 INFO - Running setup.py (path:/tmp/pip-oEGa5B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:16:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:16:59 INFO - Running setup.py (path:/tmp/pip-iNfqG7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:16:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:16:59 INFO - Running setup.py (path:/tmp/pip-m08T8Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:16:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:16:59 INFO - Running setup.py (path:/tmp/pip-BGbotX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:16:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:16:59 INFO - Running setup.py install for manifestparser 16:16:59 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:16:59 INFO - Running setup.py install for mozcrash 16:16:59 INFO - Running setup.py install for mozdebug 16:16:59 INFO - Running setup.py install for mozdevice 16:16:59 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:16:59 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:16:59 INFO - Running setup.py install for mozfile 16:16:59 INFO - Running setup.py install for mozhttpd 16:16:59 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:17:00 INFO - Running setup.py install for mozinfo 16:17:00 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:17:00 INFO - Running setup.py install for mozInstall 16:17:00 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:17:00 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:17:00 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:17:00 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:17:00 INFO - Running setup.py install for mozleak 16:17:00 INFO - Running setup.py install for mozlog 16:17:00 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:17:00 INFO - Running setup.py install for moznetwork 16:17:00 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:17:00 INFO - Running setup.py install for mozprocess 16:17:00 INFO - Running setup.py install for mozprofile 16:17:00 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:17:00 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:17:00 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:17:00 INFO - Running setup.py install for mozrunner 16:17:00 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:17:00 INFO - Running setup.py install for mozscreenshot 16:17:00 INFO - Running setup.py install for moztest 16:17:01 INFO - Running setup.py install for mozversion 16:17:01 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:17:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:17:01 INFO - Cleaning up... 16:17:01 INFO - Return code: 0 16:17:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:17:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7fbf7e648f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe08290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9a850>, '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 0xe06330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe067c0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1457302193.275829-704462114', '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 16:17:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 16:17:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:17:01 INFO - Using env: {'DISPLAY': ':0', 16:17:01 INFO - 'HOME': '/home/cltbld', 16:17:01 INFO - 'LANG': 'en_US.UTF-8', 16:17:01 INFO - 'LANGUAGE': 'en_US:en', 16:17:01 INFO - 'LOGNAME': 'cltbld', 16:17:01 INFO - 'MAIL': '/var/mail/cltbld', 16:17:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:01 INFO - 'MOZ_NO_REMOTE': '1', 16:17:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:01 INFO - 'NO_EM_RESTART': '1', 16:17:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:17:01 INFO - 'PWD': '/builds/slave/test-pgo', 16:17:01 INFO - 'SHELL': '/bin/bash', 16:17:01 INFO - 'SHLVL': '1', 16:17:01 INFO - 'TERM': 'linux', 16:17:01 INFO - 'TMOUT': '86400', 16:17:01 INFO - 'USER': 'cltbld', 16:17:01 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1457302193.275829-704462114', 16:17:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:01 INFO - '_': '/tools/buildbot/bin/python'} 16:17:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:17:01 INFO - Running setup.py (path:/tmp/pip-QotVV7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:17:01 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)) 16:17:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:17:01 INFO - Running setup.py (path:/tmp/pip-dLhP7n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:17:01 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)) 16:17:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:17:01 INFO - Running setup.py (path:/tmp/pip-4cAEpQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:17:01 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)) 16:17:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:17:01 INFO - Running setup.py (path:/tmp/pip-IkAu8M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:17:01 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)) 16:17:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:17:01 INFO - Running setup.py (path:/tmp/pip-cxE408-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:17:01 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)) 16:17:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:17:01 INFO - Running setup.py (path:/tmp/pip-ttX4UR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:17:01 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)) 16:17:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:17:01 INFO - Running setup.py (path:/tmp/pip-huwYT3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:17:02 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)) 16:17:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:17:02 INFO - Running setup.py (path:/tmp/pip-Dkr5bg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:17:02 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)) 16:17:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:17:02 INFO - Running setup.py (path:/tmp/pip-jN09Df-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:17:02 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)) 16:17:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:17:02 INFO - Running setup.py (path:/tmp/pip-kkeZcl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:17:02 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)) 16:17:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:17:02 INFO - Running setup.py (path:/tmp/pip-N662F7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:17:02 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)) 16:17:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:17:02 INFO - Running setup.py (path:/tmp/pip-1vMpPl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:17:02 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)) 16:17:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:17:02 INFO - Running setup.py (path:/tmp/pip-yBcDTl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:17:02 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)) 16:17:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:17:02 INFO - Running setup.py (path:/tmp/pip-osjsG2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:17:02 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)) 16:17:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:17:02 INFO - Running setup.py (path:/tmp/pip-5orLDt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:17:02 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)) 16:17:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:17:02 INFO - Running setup.py (path:/tmp/pip-aGT5Gb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:17:02 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)) 16:17:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:17:02 INFO - Running setup.py (path:/tmp/pip-gH1u90-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:17:02 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)) 16:17:02 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)) 16:17:02 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)) 16:17:02 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)) 16:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:17:02 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)) 16:17:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:04 INFO - Downloading blessings-1.6.tar.gz 16:17:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:17:04 INFO - Installing collected packages: blessings 16:17:04 INFO - Running setup.py install for blessings 16:17:04 INFO - Successfully installed blessings 16:17:04 INFO - Cleaning up... 16:17:04 INFO - Return code: 0 16:17:04 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:17:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:17:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:17:05 INFO - Reading from file tmpfile_stdout 16:17:05 INFO - Current package versions: 16:17:05 INFO - argparse == 1.2.1 16:17:05 INFO - blessings == 1.6 16:17:05 INFO - blobuploader == 1.2.4 16:17:05 INFO - docopt == 0.6.1 16:17:05 INFO - manifestparser == 1.1 16:17:05 INFO - mozInstall == 1.12 16:17:05 INFO - mozcrash == 0.16 16:17:05 INFO - mozdebug == 0.1 16:17:05 INFO - mozdevice == 0.48 16:17:05 INFO - mozfile == 1.2 16:17:05 INFO - mozhttpd == 0.7 16:17:05 INFO - mozinfo == 0.9 16:17:05 INFO - mozleak == 0.1 16:17:05 INFO - mozlog == 3.1 16:17:05 INFO - moznetwork == 0.27 16:17:05 INFO - mozprocess == 0.22 16:17:05 INFO - mozprofile == 0.28 16:17:05 INFO - mozrunner == 6.11 16:17:05 INFO - mozscreenshot == 0.1 16:17:05 INFO - mozsystemmonitor == 0.0 16:17:05 INFO - moztest == 0.7 16:17:05 INFO - mozversion == 1.4 16:17:05 INFO - psutil == 3.1.1 16:17:05 INFO - requests == 1.2.3 16:17:05 INFO - wsgiref == 0.1.2 16:17:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf7e648f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe08290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9a850>, '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 0xe06330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe067c0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1457302193.275829-704462114', '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 16:17:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 16:17:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:17:05 INFO - Using env: {'DISPLAY': ':0', 16:17:05 INFO - 'HOME': '/home/cltbld', 16:17:05 INFO - 'LANG': 'en_US.UTF-8', 16:17:05 INFO - 'LANGUAGE': 'en_US:en', 16:17:05 INFO - 'LOGNAME': 'cltbld', 16:17:05 INFO - 'MAIL': '/var/mail/cltbld', 16:17:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:05 INFO - 'MOZ_NO_REMOTE': '1', 16:17:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:05 INFO - 'NO_EM_RESTART': '1', 16:17:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:17:05 INFO - 'PWD': '/builds/slave/test-pgo', 16:17:05 INFO - 'SHELL': '/bin/bash', 16:17:05 INFO - 'SHLVL': '1', 16:17:05 INFO - 'TERM': 'linux', 16:17:05 INFO - 'TMOUT': '86400', 16:17:05 INFO - 'USER': 'cltbld', 16:17:05 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1457302193.275829-704462114', 16:17:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:05 INFO - '_': '/tools/buildbot/bin/python'} 16:17:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:05 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)) 16:17:05 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)) 16:17:05 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)) 16:17:05 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)) 16:17:05 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)) 16:17:05 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)) 16:17:05 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)) 16:17:05 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)) 16:17:05 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)) 16:17:05 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)) 16:17: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 mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 16:17:05 INFO - Cleaning up... 16:17:05 INFO - Return code: 0 16:17:05 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf7e648f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe08290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9a850>, '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 0xe06330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe067c0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1457302193.275829-704462114', '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 16:17:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 16:17:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:17:05 INFO - Using env: {'DISPLAY': ':0', 16:17:05 INFO - 'HOME': '/home/cltbld', 16:17:05 INFO - 'LANG': 'en_US.UTF-8', 16:17:05 INFO - 'LANGUAGE': 'en_US:en', 16:17:05 INFO - 'LOGNAME': 'cltbld', 16:17:05 INFO - 'MAIL': '/var/mail/cltbld', 16:17:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:05 INFO - 'MOZ_NO_REMOTE': '1', 16:17:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:05 INFO - 'NO_EM_RESTART': '1', 16:17:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:17:05 INFO - 'PWD': '/builds/slave/test-pgo', 16:17:05 INFO - 'SHELL': '/bin/bash', 16:17:05 INFO - 'SHLVL': '1', 16:17:05 INFO - 'TERM': 'linux', 16:17:05 INFO - 'TMOUT': '86400', 16:17:05 INFO - 'USER': 'cltbld', 16:17:05 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1457302193.275829-704462114', 16:17:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:05 INFO - '_': '/tools/buildbot/bin/python'} 16:17:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:05 INFO - Downloading/unpacking jsonschema 16:17: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 16:17: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 16:17: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 16:17: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 16:17: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 16:17: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 16:17:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:17:07 INFO - Downloading/unpacking functools32 (from jsonschema) 16:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:07 INFO - Downloading functools32-3.2.3-2.tar.gz 16:17:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:17:07 INFO - warning: no files found matching '*.txt' 16:17:07 INFO - no previously-included directories found matching 'build' 16:17:07 INFO - no previously-included directories found matching 'dist' 16:17:07 INFO - no previously-included directories found matching '.git*' 16:17:07 INFO - Installing collected packages: jsonschema, functools32 16:17:07 INFO - Running setup.py install for functools32 16:17:07 INFO - warning: no files found matching '*.txt' 16:17:07 INFO - no previously-included directories found matching 'build' 16:17:07 INFO - no previously-included directories found matching 'dist' 16:17:07 INFO - no previously-included directories found matching '.git*' 16:17:07 INFO - Successfully installed jsonschema functools32 16:17:07 INFO - Cleaning up... 16:17:07 INFO - Return code: 0 16:17:07 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:17: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')]} 16:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17: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')]} 16:17:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf7e648f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe08290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9a850>, '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 0xe06330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe067c0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1457302193.275829-704462114', '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 16:17:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 16:17:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:17:07 INFO - Using env: {'DISPLAY': ':0', 16:17:07 INFO - 'HOME': '/home/cltbld', 16:17:07 INFO - 'LANG': 'en_US.UTF-8', 16:17:07 INFO - 'LANGUAGE': 'en_US:en', 16:17:07 INFO - 'LOGNAME': 'cltbld', 16:17:07 INFO - 'MAIL': '/var/mail/cltbld', 16:17:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:07 INFO - 'MOZ_NO_REMOTE': '1', 16:17:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:07 INFO - 'NO_EM_RESTART': '1', 16:17:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:17:07 INFO - 'PWD': '/builds/slave/test-pgo', 16:17:07 INFO - 'SHELL': '/bin/bash', 16:17:07 INFO - 'SHLVL': '1', 16:17:07 INFO - 'TERM': 'linux', 16:17:07 INFO - 'TMOUT': '86400', 16:17:07 INFO - 'USER': 'cltbld', 16:17:07 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1457302193.275829-704462114', 16:17:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:07 INFO - '_': '/tools/buildbot/bin/python'} 16:17:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:08 INFO - Downloading/unpacking flake8 16:17: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 16:17: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 16:17: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 16:17: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 16:17: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 16:17: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 16:17:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:17:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:17: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 16:17: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 16:17: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 16:17: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 16:17: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 16:17: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 16:17:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:17:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:17: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 16:17: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 16:17: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 16:17: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 16:17: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 16:17: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 16:17:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:17: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 16:17: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 16:17: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 16:17: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 16:17: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 16:17: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 16:17:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:17:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:17:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:17:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:17:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:17:10 INFO - no previously-included directories found matching 'docs/_build' 16:17:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:17:11 INFO - Running setup.py install for pep8 16:17:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:17:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:17:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:17:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:17:11 INFO - no previously-included directories found matching 'docs/_build' 16:17:11 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:17:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:17:11 INFO - Cleaning up... 16:17:16 INFO - Return code: 0 16:17:16 INFO - Running post-action listener: _resource_record_post_action 16:17:16 INFO - Running post-action listener: _start_resource_monitoring 16:17:21 INFO - Starting resource monitoring. 16:17:21 INFO - ##### 16:17:21 INFO - ##### Running install step. 16:17:21 INFO - ##### 16:17:21 INFO - Running pre-action listener: _resource_record_pre_action 16:17:21 INFO - Running main action method: install 16:17:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:17:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:17:21 INFO - Reading from file tmpfile_stdout 16:17:21 INFO - Detecting whether we're running mozinstall >=1.0... 16:17:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:17:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:17:22 INFO - Reading from file tmpfile_stdout 16:17:22 INFO - Output received: 16:17:22 INFO - Usage: mozinstall [options] installer 16:17:22 INFO - Options: 16:17:22 INFO - -h, --help show this help message and exit 16:17:22 INFO - -d DEST, --destination=DEST 16:17:22 INFO - Directory to install application into. [default: 16:17:22 INFO - "/builds/slave/test-pgo"] 16:17:22 INFO - --app=APP Application being installed. [default: firefox] 16:17:22 INFO - mkdir: /builds/slave/test-pgo/build/application 16:17:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 16:17:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 16:17:44 INFO - Reading from file tmpfile_stdout 16:17:44 INFO - Output received: 16:17:44 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:17:44 INFO - Running post-action listener: _resource_record_post_action 16:17:44 INFO - ##### 16:17:44 INFO - ##### Running run-tests step. 16:17:44 INFO - ##### 16:17:44 INFO - Running pre-action listener: _resource_record_pre_action 16:17:44 INFO - Running main action method: run_tests 16:17:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:17:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:17:44 INFO - Python 2.7.3 16:17:44 INFO - Return code: 0 16:17:44 INFO - grabbing minidump binary from tooltool 16:17:44 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')]} 16:17:44 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 0xe9a850>, '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 0xe06330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe067c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:17:44 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 16:17:44 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 16:17:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:17:44 INFO - Return code: 0 16:17:44 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:17:44 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:17:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:17:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:17:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:17:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:17:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:17:45 INFO - Return code: 0 16:17:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T1cLqKpcRTCvibduD1IYww/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 16:17:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/T1cLqKpcRTCvibduD1IYww/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:17:45 INFO - Using env: {'DISPLAY': ':0', 16:17:45 INFO - 'HOME': '/home/cltbld', 16:17:45 INFO - 'LANG': 'en_US.UTF-8', 16:17:45 INFO - 'LANGUAGE': 'en_US:en', 16:17:45 INFO - 'LOGNAME': 'cltbld', 16:17:45 INFO - 'MAIL': '/var/mail/cltbld', 16:17:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:17:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:45 INFO - 'MOZ_NO_REMOTE': '1', 16:17:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:17:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:45 INFO - 'NO_EM_RESTART': '1', 16:17:45 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:17:45 INFO - 'PWD': '/builds/slave/test-pgo', 16:17:45 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:17:45 INFO - 'SHELL': '/bin/bash', 16:17:45 INFO - 'SHLVL': '1', 16:17:45 INFO - 'TERM': 'linux', 16:17:45 INFO - 'TMOUT': '86400', 16:17:45 INFO - 'USER': 'cltbld', 16:17:45 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1457302193.275829-704462114', 16:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:45 INFO - '_': '/tools/buildbot/bin/python'} 16:17:45 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T1cLqKpcRTCvibduD1IYww/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:17:45 INFO - mozversion application_buildid: 20160306135809 16:17:45 INFO - mozversion application_changeset: d6e19d0079ea3c0d04cdac5824a0675cbf3800c5 16:17:45 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:17:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:17:45 INFO - mozversion application_name: Firefox 16:17:45 INFO - mozversion application_remotingname: firefox-dev 16:17:45 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:17:45 INFO - mozversion application_vendor: Mozilla 16:17:45 INFO - mozversion application_version: 46.0a2 16:17:45 INFO - mozversion platform_buildid: 20160306135809 16:17:45 INFO - mozversion platform_changeset: d6e19d0079ea3c0d04cdac5824a0675cbf3800c5 16:17:45 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:17:45 INFO - mozversion platform_version: 46.0a2 16:17:45 INFO - using testdate: 1457309865 16:17:45 INFO - actual date: 1457309865 16:17:45 INFO - starting webserver on 'localhost:39841' 16:17:45 INFO - SUITE-START | Running 3 tests 16:17:45 INFO - TEST-START | dromaeo_css 16:17:45 INFO - operating with platform_type : linux_ 16:17:45 INFO - Initialising browser for dromaeo_css test... 16:17:45 INFO - TEST-INFO | started process 8042 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp405a9p/profile http://localhost:39841/getInfo.html) 16:17:55 INFO - PROCESS | 8042 | 16:17:55 INFO - PROCESS | 8042 | (process:8122): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:17:59 INFO - PROCESS | 8042 | __metrics Screen width/height:1600/1200 16:17:59 INFO - PROCESS | 8042 | colorDepth:24 16:17:59 INFO - PROCESS | 8042 | Browser inner width/height: 1024/697 16:17:59 INFO - PROCESS | 8042 | __metrics 16:18:01 INFO - TEST-INFO | 8042: exit 0 16:18:01 INFO - Browser initialized. 16:18:01 INFO - Running cycle 1/1 for dromaeo_css test... 16:18:01 INFO - TEST-INFO | started process 8171 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp405a9p/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:18:03 INFO - PROCESS | 8171 | 16:18:03 INFO - PROCESS | 8171 | (process:8232): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:18:13 INFO - PROCESS | 8171 | RSS: Main: 141541376 16:18:13 INFO - PROCESS | 8171 | 16:19:03 INFO - PROCESS | 8171 | 1457309943252 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] 16:21:14 INFO - PROCESS | 8171 | Cycle 1(1): loaded http://localhost:39841/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39841/tests/dromaeo/cssquery-ext.html) 16:21:15 INFO - PROCESS | 8171 | RSS: Main: 146350080 16:21:15 INFO - PROCESS | 8171 | 16:24:17 INFO - PROCESS | 8171 | Cycle 1(1): loaded http://localhost:39841/tests/dromaeo/cssquery-ext.html (next: http://localhost:39841/tests/dromaeo/cssquery-jquery.html) 16:24:18 INFO - PROCESS | 8171 | RSS: Main: 144318464 16:24:18 INFO - PROCESS | 8171 | 16:27:19 INFO - PROCESS | 8171 | Cycle 1(1): loaded http://localhost:39841/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39841/tests/dromaeo/cssquery-mootools.html) 16:27:20 INFO - PROCESS | 8171 | RSS: Main: 143052800 16:27:20 INFO - PROCESS | 8171 | 16:30:21 INFO - PROCESS | 8171 | Cycle 1(1): loaded http://localhost:39841/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39841/tests/dromaeo/cssquery-prototype.html) 16:30:22 INFO - PROCESS | 8171 | RSS: Main: 143626240 16:30:22 INFO - PROCESS | 8171 | 16:33:24 INFO - PROCESS | 8171 | Cycle 1(1): loaded http://localhost:39841/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39841/tests/dromaeo/cssquery-yui.html) 16:33:25 INFO - PROCESS | 8171 | RSS: Main: 143372288 16:33:25 INFO - PROCESS | 8171 | 16:36:27 INFO - PROCESS | 8171 | Cycle 1(1): loaded http://localhost:39841/tests/dromaeo/cssquery-yui.html (next: http://localhost:39841/tests/dromaeo/cssquery-dojo.html) 16:36:27 INFO - PROCESS | 8171 | RSS: Main: 146604032 16:36:27 INFO - PROCESS | 8171 | 16:36:27 INFO - PROCESS | 8171 | __start_tp_report 16:36:27 INFO - PROCESS | 8171 | _x_x_mozilla_page_load 16:36:27 INFO - PROCESS | 8171 | _x_x_mozilla_page_load_details 16:36:27 INFO - PROCESS | 8171 | |i|pagename|runs| 16:36:27 INFO - PROCESS | 8171 | |0;dojo.html;3360.5967283925916;3376.5104059911328;3401.1667141550356;3411.9488207676873;3417.1798768295585;5531.115021596545;5536.446355364462;5551.666899986004;5555.3611334696525;5565.1374037024225;5528.5024347808685;5592.748326325315;5610.607257491977;5638.915416268739;5677.914831277534;5063.8480845574695;5081.542661160494;5170.431252562215;5171.327727395434;5178.378594568639;4895.069936712031;4985.576226020775;5035.395752509704;5098.26075219093;5100.464451232623;5032.647714659957;5063.291139240509;5157.690538567679;5159.819406320779;5166.638335316529;5040;5042.865355295066;5056.81164926242;5078.97460512695;5096.541311281965;4930.926036109426;4946.183879659852;4980.576650984671;4992.951480189165;5031.4465408805;5317.202419637047;5330.440303768126;5390.946090539083;5405.486478784548;5423.240746295522;5814.592978491507;5819.883602327972;5890.587658863881;5898.823035308905;5906.616069955439;5816.360200377955;5850.444207800252;5868.2371291732225;5959.463648271676;5985.191999080155;5563.693996830132;5565.499105080562;5569.665820050729;5576.9163462548095;5592.356878958931;6035.849103772441;6048.4858787003595;6055.455009049207;6057.939420605826;6064;5678.545716342683;5734.684592347461;5795.8551036224435;5796.62321949072;5914;5908.970455147697;5910.911336329958;5923.970380148072;5927.940720592739;5939.46544810969;5874.206982057453;5878.265216847894;5879.794207202727;5892;5894.587378883522;5809.186713860063;5852.356240813507;5875.177475153482;5935.821925342247;5943.435373639497;4439.866803995886;4441.089576636782;4448.288273876165;4450.799714012877;4469.754163520973;4020.6984476164403;4028;4031.677465802729;4039.6970227233073;4075.612816782401;5608.69152196625;5630.493255607015;5667.1782591524825;5708.20085188074;5737.340205876294;5837.94162058374;5893.410658934158;5905.084711869667;5909.113632955005;5914.290285165807;5474.124140137559;5525.309336332958;5585.972070139624;5615.410381909841;5635.0702134147405;5028.924566131511;5151.407588127413;5152.793888244429;5159.845204643867;5196.53231209193;6029.909551356734;6056.273247210363;6069.180660610761;6090.36051214625;6098.847528811638;5865;5939.376365481562;5959.73181206838;5968.283805943314;5975.193348897843;6033.336333003454;6053.909191362045;6091;6094.878102437838;6106.816795496142;5864.912026319524;5876.147958546072;5899.4985426239255;5910.674912879833;5914.881702366015;5915.171875937458;5984.162217289496;5987.371326010706;5995.760169593167;6007.189029481139;5797.710114494343;5812.622179558315;5825.126231065374;5854.356020837789;5890.558208134321;5824.21373114641;5846.912296315644;5857.238558987475;5863.677497737665;5877.853053673693;5607.355154157324;5622.184783206494;5655.4344565543115;5663.093904975184;5701.572382071278;5733.140028995684;5814.825555233349;5909.113632954919;5925.496332811759;5959.493443057216;5705.34388545306;5725.08398656213;5739.971300143473;5741.0527263002805;5764.423557644202 16:36:27 INFO - PROCESS | 8171 | |1;ext.html;554.3984776517478;560.3639868748969;579.6811753535552;581.549299293048;603.9822898416172;31830.20424489389;32412.67587324126;39827.800860995725;39965;40189.19621607566;45468.77265613675;46159;46334.07331853361;46383.536164638346;46489.30266046012;9022.233110185642;9187.310951678617;9230;9246.26029917605;9256.120668536478;8849.07084756101;8930.86603700945;8949.149830766068;8967.46195228285;8985.550722463851;8907.554622268894;8955.641774329019;8983.10168983103;8984.46093234408;8991.3256505762;8906.332025098143;8910.064443233465;8944.597493112826;8988.59551320192;9036.45781253127;8889.377743557954;9021.819563608757;9023.4134781239;9032.593533291018;9049.457032578066;42334.36498452526;42574.78712606417;42629.78685106586;42708;42964.78517607392;3704.759190652626;3740.9064773380883;3893.805309734502;4296.334068219399;4421.977890110561;28511;28529.286767830763;28708.282292942844;30838.691613083807;34076;4214.683898707579;4358.956410435919;4366.08312254427;4383.728414403546;4436.44544431946;219378;219823;220115;408245;419967.9001605003;64875;65285;65708;66360;66530.66734666392;68524;69078;69120;69132.654336728;69266.307336927;15858.127802970947;16068.35726570924;16160.676786464204;16204.75692864608;16210.513684589481;11981.400929953468;11991.580294689644;12027.819582706266;12049.397530123459;12110.878891211152;21968.89015554912;22145.446363841034;22186.44533886666;22338.21816236424;22367.10531578751;8653.956730216309;8721.825563488695;8745;8826.382153249338;8911.50986695725;1015.6673142953678;1051.7055224537141;1101.8181999970075;1177.0465922602718;1179.3808250668296;29926.25184370408;29989.850050749606;30658.846705766773;30743.692563074084;31209.531857022164;1126.8591426071741;1137.3573930729112;1152.654203738875;1204.5663561118165;1218.6465924881861;15383.384664613513;16155.273012714457;17698.734518981968;17721.202545885466;18705.064746762608;531597;532738;539726;543691;546298;55640.16539751907;55960.440395596335;56130.43869561252;56131.158032629544;56169.43830561724;1451.397669966973;1464.5899148238511;1489.0990950474807;1494.6637006673411;1500.8424115467938;32393.514097288087;32775.50836737498;33009;33055;33141.337173256885;48894.51105489042;49900.75049624729;49930.75034624804;49960.50118496451;50001.49998499968;328647;329091;329881;330221;330713;34154.65845341515;45687;47808.04383912233;48182;48412.03175936391;47137.76431117822;47847;47855;48228.758856205495;48555.27167092567;39504.407433887936;39656;39954.40068398918;40115.79942100271;40507;40912.38631420471;41444.79277603592;42558.148837023706;43067.87581181743;46234.768826157;39711;40896;41022.17955640811;41180;41372;34654;35019.824900875334;35612.28775424529;35798.46302305415;35980.820095899355;27238.182854514398;27709.861450693425;27764.861175693994;27971.58042629403;28012.159635210977 16:36:27 INFO - PROCESS | 8171 | |2;jquery.html;375.6975634614136;377.0573566084788;383.29091181314556;383.33874067234007;385.6933737678543;15719.685606287896;16114.838851611481;17632.030238336887;18303.627227957924;18375.44873653789;14603.488877889276;16995.915020424913;17096.401625943094;17868.55328616785;17917.193726282316;5092.465291144441;5385.3537575491;5779.393163717791;5820.806734619414;5836;5277.419483856773;5439.972800135994;5459.890802183954;5729.28383952006;5822.650640961535;5111.948880511203;5247.685138891659;5411.675299482024;5456.399796022434;5469.179623056533;5492.670439773627;5499.175123731432;5518.889622207554;5521.4478552144865;5522.22688823563;5222.63441559091;5540.2243685884005;5549.306336707911;5553.111502159675;5557.805476808333;20914.268000619904;20941.685874711893;21514.354569362946;21535.67696484554;21685.891570542204;2180.7056047433553;2220;2255.3572231913827;2282.600544904635;2377.6314671225987;10433.21750868688;10675.41285229312;10786.191035672278;11448.599299024494;14326.068805527711;1897.7532920720357;1918.88486690799;1919.299455698674;1944.3680803738841;1962.705594160873;57686.71156644232;59533.7023314885;60136;60411.697941510014;61168.694156529375;10582.365058096539;10902.236843421044;10908.509117089592;11010.064144547803;11034.668959931216;14633.195174265305;14700;14703.191324477042;14776.48282310114;14784.556463306119;7927.762167134995;7942.324902383247;8040.15578364275;8043.356531477468;8071.313938315191;7605.277498637731;7659.731909383257;7662.5402475850515;7692.384609231248;7702.499337543042;4316.503602085738;4532.481618657786;4731.2903064539905;4779.713217206979;4842.055799119138;1926.7784204816346;1995.30164442444;2004.7193392925003;2014.0735261779746;2043.7956204379443;982.6118683120128;1003.172382784206;1036.8789942273659;1084.8535447714457;1086.02257967828;16503.33986640521;16521.173941302888;16678.499645010426;16878.409255675993;17560.121993900255;974.4104816586005;1010.3786171504619;1061.3260579531898;1087.3739918097863;1118.6588090632272;8363.916360836436;10403.58385664565;10419.426931518688;10544.26190166681;10638.361698298128;565191.5221271684;588084;588105;588843;600231;72997.6350118246;73467;74639;76465;77604;1144.7252659361693;1167.795635763738;1173.8180582009802;1184.4018770520831;1198.8621308549627;16061.75907361414;16086.356545738508;16271.186440677682;16467.176641167654;16570.254338554554;32863.178420539676;34270.828645856614;34549.827250863586;34935.475967859995;35242.64757352394;38303.654081602006;42952.78523607362;45090.77454612706;45246.321305179794;45353.31970020518;8090.878636820335;8276.08963014056;8381.49711017341;8412.579371031301;8425.83148337042;11327.490262938023;11353.602623908124;11546;12157.69605759863;12275.75448491043;9920.355176913477;10849.240553161202;11023.283486573348;11055.447227638426;11389.373584452935;10452.529636166542;11027.61403350879;11077.778444430905;11352.148588856035;11488.080953523531;9905.455199964072;10720.35677859331;10758.73103172427;11042.33745975244;11045.005949464587;8345.707900223462;8550.273226775793;8555.144485551395;8562.828743425222;8633.8704919425;9745.415275083518;10201.38791672502;10337.431441270803;10418.583256669648;10500.737481562717 16:36:27 INFO - PROCESS | 8171 | |3;mootools.html;1506.4426162319944;1514.4320879670124;1705.624762552238;1841.7513635659182;1851.6204178143482;8376.62305196266;8385.790355241123;8493.78765530862;8573.914260857397;8582.442141260814;8470.152984701526;8489.193526614961;8600.268977136935;8640;8643.611037503311;2435.220729366599;2461.4215659320043;2465.878025498403;2467.222824810188;2472.938176545583;2445.877706114696;2485.5526005319034;2520.1179587144443;2520.155747824481;2524.0408644714985;2144.07804644003;2185.868847869133;2398.052769156191;2417.7703118203744;2432.72023717273;2407.5786737320987;2415.070197973775;2427.8786060696893;2428.76926691964;2437.244454219198;2360.5160942006846;2372.41875740443;2390.7131144262626;2403.3510952042852;2408.157144999254;8417.158284171595;8444.113368096323;8471.872921906177;8495.915040849573;8509.489430634181;4994.725290109042;5162.638615296931;5169.534741873212;5173.896522069537;5193.714345710984;3229.0958531611186;3244.448443764542;3261.4455542557585;3285.195127193853;3316.950245746316;1107.9667609971714;1108.6563165418745;1117.3351855645878;1132.2300835431904;1157.5254145800182;11961.162718609701;11971.281723096556;11987.861153190346;11995.760084798343;12031.097667674872;4463.35281384204;4541.5940279826245;4577.267637178035;4581.427321584802;4600.907981840412;9513.762155946019;9569.473678947725;9592.95203523978;9627.181689556326;9638.180754635794;5001.174806157016;5004.574611158092;5016.2224855147515;5034.370703662043;5036.722980236123;4546.090781843644;4572.382728331632;4579.862604121881;4622.399088118523;4631.421072365954;3753.793541355252;3777.6788972937607;3795.6014618465215;3801.334766415866;3841.980790096032;1115.654147214366;1139.9487023083982;1149.1955631058127;1157.4039369724599;1173.342927960345;1083.9295445796;1145.0782120392996;1148.7128217945515;1155.7861795567846;1230.028277660638;7745.186755390716;7861.606919653995;7887.2112788721815;7969.924060251908;7975.60121993898;1101.1851230089676;1139.5214010115772;1146.6502716671496;1170.1399471388522;1173.3253379306761;6040.456358927718;6083.8479038023515;6162.691865406712;6174.722137503823;6192.133101365813;9919.206463482904;10507.737306567396;10514.474276286155;10557.9472102639;10620.09729173029;10214.489275536194;10283.794324113476;10320.329178603366;10322.793544129076;10410.167186625053;8048.356131509465;8089.757307280791;8091.595420228965;8112.310453611509;8160.714374996846;7634.885476717743;7658.770236892902;7700.961495192488;7748.728794492165;7875.291223789886;9298.488583127993;9322.580483878377;9405.341626086109;9459.716208513755;9465;9371.625134994523;9382.624695012122;9401.482918439278;9456.101670341306;9494.810103797747;7549.886751698838;7679.539227646359;7680.884786728316;7748.031496062992;7771.106322772727;8061.677532898619;8175.427720059539;8203.179682031749;8210.261076503144;8213.301869341172;7841.607919603883;7879.803004924923;7934.841303174019;7974.202579742211;8098;6820.147481564804;7026.718931242693;7427.740029098955;7451.962740186264;7489.28851759082;7288.781336559911;7344.742933997284;7361.227071157666;7391.0761154855645;7418.517796343221;6879.449644028566;6951.687174077279;6953.826154346182;6958.06066181059;6983.790486285419;6807.591544507345;6820.147481564804;6836.93163068363;6855;6857.657117144223 16:36:27 INFO - PROCESS | 8171 | |4;prototype.html;363.14841696222356;363.92903383840127;366.5849819695973;369.08651088555825;372.19791349641497;6367.235931688198;6425.100485931974;6446.228121907584;6474.384933431323;6512.3487651234855;6377.489800815935;6381.393767592083;6382.457491113261;6407.263164736057;6429.485641148709;4900.387451568554;4929.668989372876;4932.975335123319;4936.481669424713;4946.7526623668855;4937.876553086166;4938.80244790208;4945.975270123644;4948.2330238812865;4948.307236986825;4701.48283688794;4757.571818536331;4814.350062741538;4814.687045342059;4830.6135509159185;4788.976055119737;4810.422749270093;4812.783424745895;4827.372441582607;4829.613630909519;4233.809478573472;4237.237297286487;4241.533431322583;4243.384709217177;4251.638610718092;5963.105534169866;6005.699715014275;6042.244719410074;6053.031514957585;6053.4551890330085;5593.52455041322;5696.202531645573;5706.3722990471015;5720.628159169641;5731.942680573225;6706.429953453913;6752.729890804362;6759;6775.864482710367;6776.457883369319;4728.621710263171;4737.928931066037;4746.430428348585;4756.904861902743;4765.666403351766;6927.653617319113;6962.930370696279;6999.895001574981;7047.189573199096;7080.150381954199;4845.3216549683075;4859.392575928009;4870.95129048705;4882.340883980617;4883;4883.243097319921;4928.334674818853;4934.284528743384;4939.456659767423;4945.9258111128365;5676.233708449389;5694.743736531783;5697.914531282034;5699.059655156852;5705.71471426427;6645.501587380966;6792.252852186256;6792.796216113525;6842.897356539655;6855;1724.3275122702157;1744.8516876065423;1745.7555942168106;1747.2923465996037;1750.6673731990882;1161.8605767307808;1171.9941400292944;1175.9588414405455;1180.7520420711746;1183.47335435732;6534.4445722113205;6564.704588293538;6576.5067619928695;6597.901031484532;6606.6036037837885;7047.929520704727;7059.682314295869;7069.363757261871;7070.257622949516;7086;6453.677316134174;6512.902306465407;6552.180977377828;6589.505787065989;6632.602043877383;3814.256220037066;3835.0412396900774;3845.250176215611;3854.6338097880657;3856;7277.417806575567;7281.5631062136445;7282.235365286675;7292.635368231673;7293.380062694624;7080.433565314763;7235.131784185826;7263.527870688388;7269.127704675367;7272.890906636405;7269;7274.927250727531;7283.126024876943;7284.34121545632;7286.526375785557;7060.576365418091;7064.399526040344;7072.08062951813;7075.327843854826;7115.501914865909;6788.117544719353;6995.580265183901;7007.474439416962;7016.789496315118;7050.400715939202;7250.709971601077;7279.090113735783;7305.525140865827;7317.963410182915;7328.230535793665;4868.172410690262;4934.802607895787;4936.629752768628;4942.8022879085875;4948.703077815343;6934.375906168469;7116.893246601202;7120.216776154515;7131.965864949657;7142.642867856483;6900.447964162755;6930.549514281555;6936.098307220029;6958.965205173941;6962.885938249856;6670.566413183322;6830.45356371499;6836.623985680835;6862.107925969792;6894.931050689429;6730.192376914802;6782.287859774653;6789.219239787488;6795.28649491816;6800.183977922681;6910.619915904674;6942.479314051366;6950.339717726808;6957.721691132298;6963.423533292714;6606.10817539626;6741.258461569126;6745.797626071226;6752.324767523209;6753 16:36:27 INFO - PROCESS | 8171 | |5;yui.html;769.569041336851;790.2650535002446;821.9465734727243;911.7766147293912;939.0797018921456;14252.857471425283;14407.927960360183;14426.783598246035;14455.349509272068;14490.5652830415;14120.364583593737;14131;14187.716245675107;14214.289285535733;14225.644358891033;883.9558022098886;892.054422312351;895.1630225738922;918.9081091890824;922.9400088994228;917.4082716647758;922.575615217001;923.3674932671108;925.1719710858811;929.4748467116058;958.3435346787472;961.7643677299071;963.8457846744523;965.5172413793103;967.4147140979711;941.3081385181886;943.9811203775955;946.6024269806663;950.116391755667;959.6161535385831;702.3117345001875;709.4856229233816;712.0316369737153;714.5748279773527;716.3051839715467;14340.92829535856;14416.062955907832;14425.78361324581;14490.130592164398;14604.853951460456;14364.64088397788;14484.49304274356;14568.417263309455;14670.119792812466;14733.55799326022;11595.768084638345;11706.414679266089;11708.53165873364;11878.109141814399;11931;3961.861334853295;3993.900152496182;4022.0950286185375;4031.1333063391216;4050.4936882889638;51758.74120629411;51761.74119129418;51799;51822.74088629533;52010.479895200944;10951.123910087173;11124.221304508768;11211.943940280247;11397.373144477133;11540.192186547029;20273;20273.391798246077;20311.796882031285;20353.473489488348;20409.387718368474;7408.814779630445;7414.184439711627;7811.843763124706;7857.960710196527;8110.513369197749;4329.458817647794;4386.561343865588;4443.688941774045;4469.039156581351;4502.3471596618965;3140.262038420969;3156.337169194495;3180.507021411685;3183.3474137801695;3186.7928584641922;584.1354794903482;593.2406519654849;593.7476572456688;600.7386786747778;605.2827399531569;589.2310534752189;670.792054463118;714.2179313651543;715.1204019056589;741.7181471040969;9023.187913087853;9419.858702119474;9540.189083927944;9814.214862810957;9938.254630902711;690.7582346178797;770.7186876790043;777.3819813248481;809.2756982500747;833.1044127562894;4344.804483798237;4507.3689683444345;4564.246899261651;4565.292379681155;4660.184467718136;59591;59809.401905981256;60038;60414;60484;51534.74232628813;54199.187012194845;54316.45683543193;54345.45654543404;54468.182977255376;47200.76399618049;47358.76320618375;47848.282275765894;49198.50801491939;50095.74952125216;8852.513111778913;8872.778180545538;8928.642854285756;9195.77010574741;9248.768780780534;36193.81903090573;36368.45447318239;36493;37508;37674.246515069;41745;41972.580274196866;47807;48022;48055;10911.78176436451;11200.719982000515;11698.35659038761;11895.82156267674;11942.940285298519;11254.324740515594;11918.642440726791;12005.039596832406;12100;14127.929360353133;12457.875421245672;12461.133581083635;12606.306653134166;12616.432260548114;13038.934805326293;13003.414846331749;13115.475380984653;13187.477995249164;13624.114432561852;13860.792088118887;12634.494620215457;12778.169418988107;13072.934635326763;13371.665708357368;13472.932635336761;9769.853452198366;9801.9019809801;9812.754681133028;9962.55168517404;10409.115225205942;9983.066922897406;10081.69754907354;10548.261621686408;10672.786544269227;10681.03870651645 16:36:27 INFO - PROCESS | 8171 | __end_tp_report 16:36:27 INFO - PROCESS | 8171 | __start_cc_report 16:36:27 INFO - PROCESS | 8171 | _x_x_mozilla_cycle_collect,298 16:36:27 INFO - PROCESS | 8171 | __end_cc_report 16:36:27 INFO - PROCESS | 8171 | __startTimestamp1457310987980__endTimestamp 16:36:27 INFO - PROCESS | 8171 | 16:36:27 INFO - PROCESS | 8171 | ------- Summary: start ------- 16:36:27 INFO - PROCESS | 8171 | Number of tests: 6 16:36:27 INFO - PROCESS | 8171 | 16:36:27 INFO - PROCESS | 8171 | [#0] dojo.html Cycles:165 Average:5507.73 Median:5733.14 stddev:602.15 (10.5%) stddev-sans-first:579.96 16:36:27 INFO - PROCESS | 8171 | Values: 3360.6 3376.5 3401.2 3411.9 3417.2 5531.1 5536.4 5551.7 5555.4 5565.1 5528.5 5592.7 5610.6 5638.9 5677.9 5063.8 5081.5 5170.4 5171.3 5178.4 4895.1 4985.6 5035.4 5098.3 5100.5 5032.6 5063.3 5157.7 5159.8 5166.6 5040.0 5042.9 5056.8 5079.0 5096.5 4930.9 4946.2 4980.6 4993.0 5031.4 5317.2 5330.4 5390.9 5405.5 5423.2 5814.6 5819.9 5890.6 5898.8 5906.6 5816.4 5850.4 5868.2 5959.5 5985.2 5563.7 5565.5 5569.7 5576.9 5592.4 6035.8 6048.5 6055.5 6057.9 6064.0 5678.5 5734.7 5795.9 5796.6 5914.0 5909.0 5910.9 5924.0 5927.9 5939.5 5874.2 5878.3 5879.8 5892.0 5894.6 5809.2 5852.4 5875.2 5935.8 5943.4 4439.9 4441.1 4448.3 4450.8 4469.8 4020.7 4028.0 4031.7 4039.7 4075.6 5608.7 5630.5 5667.2 5708.2 5737.3 5837.9 5893.4 5905.1 5909.1 5914.3 5474.1 5525.3 5586.0 5615.4 5635.1 5028.9 5151.4 5152.8 5159.8 5196.5 6029.9 6056.3 6069.2 6090.4 6098.8 5865.0 5939.4 5959.7 5968.3 5975.2 6033.3 6053.9 6091.0 6094.9 6106.8 5864.9 5876.1 5899.5 5910.7 5914.9 5915.2 5984.2 5987.4 5995.8 6007.2 5797.7 5812.6 5825.1 5854.4 5890.6 5824.2 5846.9 5857.2 5863.7 5877.9 5607.4 5622.2 5655.4 5663.1 5701.6 5733.1 5814.8 5909.1 5925.5 5959.5 5705.3 5725.1 5740.0 5741.1 5764.4 16:36:27 INFO - PROCESS | 8171 | 16:36:27 INFO - PROCESS | 8171 | [#1] ext.html Cycles:180 Average:56645.77 Median:212091.29 stddev:107959.44 (50.9%) stddev-sans-first:108180.15 16:36:27 INFO - PROCESS | 8171 | Values: 554.4 560.4 579.7 581.5 604.0 31830.2 32412.7 39827.8 39965.0 40189.2 45468.8 46159.0 46334.1 46383.5 46489.3 9022.2 9187.3 9230.0 9246.3 9256.1 8849.1 8930.9 8949.1 8967.5 8985.6 8907.6 8955.6 8983.1 8984.5 8991.3 8906.3 8910.1 8944.6 8988.6 9036.5 8889.4 9021.8 9023.4 9032.6 9049.5 42334.4 42574.8 42629.8 42708.0 42964.8 3704.8 3740.9 3893.8 4296.3 4422.0 28511.0 28529.3 28708.3 30838.7 34076.0 4214.7 4359.0 4366.1 4383.7 4436.4 219378.0 219823.0 220115.0 408245.0 419967.9 64875.0 65285.0 65708.0 66360.0 66530.7 68524.0 69078.0 69120.0 69132.7 69266.3 15858.1 16068.4 16160.7 16204.8 16210.5 11981.4 11991.6 12027.8 12049.4 12110.9 21968.9 22145.4 22186.4 22338.2 22367.1 8654.0 8721.8 8745.0 8826.4 8911.5 1015.7 1051.7 1101.8 1177.0 1179.4 29926.3 29989.9 30658.8 30743.7 31209.5 1126.9 1137.4 1152.7 1204.6 1218.6 15383.4 16155.3 17698.7 17721.2 18705.1 531597.0 532738.0 539726.0 543691.0 546298.0 55640.2 55960.4 56130.4 56131.2 56169.4 1451.4 1464.6 1489.1 1494.7 1500.8 32393.5 32775.5 33009.0 33055.0 33141.3 48894.5 49900.8 49930.8 49960.5 50001.5 328647.0 329091.0 329881.0 330221.0 330713.0 34154.7 45687.0 47808.0 48182.0 48412.0 47137.8 47847.0 47855.0 48228.8 48555.3 39504.4 39656.0 39954.4 40115.8 40507.0 40912.4 41444.8 42558.1 43067.9 46234.8 39711.0 40896.0 41022.2 41180.0 41372.0 34654.0 35019.8 35612.3 35798.5 35980.8 27238.2 27709.9 27764.9 27971.6 28012.2 16:36:27 INFO - PROCESS | 8171 | 16:36:27 INFO - PROCESS | 8171 | [#2] jquery.html Cycles:180 Average:29541.68 Median:2237.68 stddev:95676.01 (4275.7%) stddev-sans-first:95919.34 16:36:27 INFO - PROCESS | 8171 | Values: 375.7 377.1 383.3 383.3 385.7 15719.7 16114.8 17632.0 18303.6 18375.4 14603.5 16995.9 17096.4 17868.6 17917.2 5092.5 5385.4 5779.4 5820.8 5836.0 5277.4 5440.0 5459.9 5729.3 5822.7 5111.9 5247.7 5411.7 5456.4 5469.2 5492.7 5499.2 5518.9 5521.4 5522.2 5222.6 5540.2 5549.3 5553.1 5557.8 20914.3 20941.7 21514.4 21535.7 21685.9 2180.7 2220.0 2255.4 2282.6 2377.6 10433.2 10675.4 10786.2 11448.6 14326.1 1897.8 1918.9 1919.3 1944.4 1962.7 57686.7 59533.7 60136.0 60411.7 61168.7 10582.4 10902.2 10908.5 11010.1 11034.7 14633.2 14700.0 14703.2 14776.5 14784.6 7927.8 7942.3 8040.2 8043.4 8071.3 7605.3 7659.7 7662.5 7692.4 7702.5 4316.5 4532.5 4731.3 4779.7 4842.1 1926.8 1995.3 2004.7 2014.1 2043.8 982.6 1003.2 1036.9 1084.9 1086.0 16503.3 16521.2 16678.5 16878.4 17560.1 974.4 1010.4 1061.3 1087.4 1118.7 8363.9 10403.6 10419.4 10544.3 10638.4 565191.5 588084.0 588105.0 588843.0 600231.0 72997.6 73467.0 74639.0 76465.0 77604.0 1144.7 1167.8 1173.8 1184.4 1198.9 16061.8 16086.4 16271.2 16467.2 16570.3 32863.2 34270.8 34549.8 34935.5 35242.6 38303.7 42952.8 45090.8 45246.3 45353.3 8090.9 8276.1 8381.5 8412.6 8425.8 11327.5 11353.6 11546.0 12157.7 12275.8 9920.4 10849.2 11023.3 11055.4 11389.4 10452.5 11027.6 11077.8 11352.1 11488.1 9905.5 10720.4 10758.7 11042.3 11045.0 8345.7 8550.3 8555.1 8562.8 8633.9 9745.4 10201.4 10337.4 10418.6 10500.7 16:36:27 INFO - PROCESS | 8171 | 16:36:27 INFO - PROCESS | 8171 | [#3] mootools.html Cycles:180 Average:5927.15 Median:5166.09 stddev:3134.09 (60.7%) stddev-sans-first:3125.26 16:36:27 INFO - PROCESS | 8171 | Values: 1506.4 1514.4 1705.6 1841.8 1851.6 8376.6 8385.8 8493.8 8573.9 8582.4 8470.2 8489.2 8600.3 8640.0 8643.6 2435.2 2461.4 2465.9 2467.2 2472.9 2445.9 2485.6 2520.1 2520.2 2524.0 2144.1 2185.9 2398.1 2417.8 2432.7 2407.6 2415.1 2427.9 2428.8 2437.2 2360.5 2372.4 2390.7 2403.4 2408.2 8417.2 8444.1 8471.9 8495.9 8509.5 4994.7 5162.6 5169.5 5173.9 5193.7 3229.1 3244.4 3261.4 3285.2 3317.0 1108.0 1108.7 1117.3 1132.2 1157.5 11961.2 11971.3 11987.9 11995.8 12031.1 4463.4 4541.6 4577.3 4581.4 4600.9 9513.8 9569.5 9593.0 9627.2 9638.2 5001.2 5004.6 5016.2 5034.4 5036.7 4546.1 4572.4 4579.9 4622.4 4631.4 3753.8 3777.7 3795.6 3801.3 3842.0 1115.7 1139.9 1149.2 1157.4 1173.3 1083.9 1145.1 1148.7 1155.8 1230.0 7745.2 7861.6 7887.2 7969.9 7975.6 1101.2 1139.5 1146.7 1170.1 1173.3 6040.5 6083.8 6162.7 6174.7 6192.1 9919.2 10507.7 10514.5 10557.9 10620.1 10214.5 10283.8 10320.3 10322.8 10410.2 8048.4 8089.8 8091.6 8112.3 8160.7 7634.9 7658.8 7701.0 7748.7 7875.3 9298.5 9322.6 9405.3 9459.7 9465.0 9371.6 9382.6 9401.5 9456.1 9494.8 7549.9 7679.5 7680.9 7748.0 7771.1 8061.7 8175.4 8203.2 8210.3 8213.3 7841.6 7879.8 7934.8 7974.2 8098.0 6820.1 7026.7 7427.7 7452.0 7489.3 7288.8 7344.7 7361.2 7391.1 7418.5 6879.4 6951.7 6953.8 6958.1 6983.8 6807.6 6820.1 6836.9 6855.0 6857.7 16:36:27 INFO - PROCESS | 8171 | 16:36:27 INFO - PROCESS | 8171 | [#4] prototype.html Cycles:180 Average:5714.25 Median:6512.63 stddev:1721.96 (26.4%) stddev-sans-first:1679.30 16:36:27 INFO - PROCESS | 8171 | Values: 363.1 363.9 366.6 369.1 372.2 6367.2 6425.1 6446.2 6474.4 6512.3 6377.5 6381.4 6382.5 6407.3 6429.5 4900.4 4929.7 4933.0 4936.5 4946.8 4937.9 4938.8 4946.0 4948.2 4948.3 4701.5 4757.6 4814.4 4814.7 4830.6 4789.0 4810.4 4812.8 4827.4 4829.6 4233.8 4237.2 4241.5 4243.4 4251.6 5963.1 6005.7 6042.2 6053.0 6053.5 5593.5 5696.2 5706.4 5720.6 5731.9 6706.4 6752.7 6759.0 6775.9 6776.5 4728.6 4737.9 4746.4 4756.9 4765.7 6927.7 6962.9 6999.9 7047.2 7080.2 4845.3 4859.4 4871.0 4882.3 4883.0 4883.2 4928.3 4934.3 4939.5 4945.9 5676.2 5694.7 5697.9 5699.1 5705.7 6645.5 6792.3 6792.8 6842.9 6855.0 1724.3 1744.9 1745.8 1747.3 1750.7 1161.9 1172.0 1176.0 1180.8 1183.5 6534.4 6564.7 6576.5 6597.9 6606.6 7047.9 7059.7 7069.4 7070.3 7086.0 6453.7 6512.9 6552.2 6589.5 6632.6 3814.3 3835.0 3845.3 3854.6 3856.0 7277.4 7281.6 7282.2 7292.6 7293.4 7080.4 7235.1 7263.5 7269.1 7272.9 7269.0 7274.9 7283.1 7284.3 7286.5 7060.6 7064.4 7072.1 7075.3 7115.5 6788.1 6995.6 7007.5 7016.8 7050.4 7250.7 7279.1 7305.5 7318.0 7328.2 4868.2 4934.8 4936.6 4942.8 4948.7 6934.4 7116.9 7120.2 7132.0 7142.6 6900.4 6930.5 6936.1 6959.0 6962.9 6670.6 6830.5 6836.6 6862.1 6894.9 6730.2 6782.3 6789.2 6795.3 6800.2 6910.6 6942.5 6950.3 6957.7 6963.4 6606.1 6741.3 6745.8 6752.3 6753.0 16:36:27 INFO - PROCESS | 8171 | 16:36:27 INFO - PROCESS | 8171 | [#5] yui.html Cycles:180 Average:14730.75 Median:4612.74 stddev:16684.95 (361.7%) stddev-sans-first:16698.81 16:36:27 INFO - PROCESS | 8171 | Values: 769.6 790.3 821.9 911.8 939.1 14252.9 14407.9 14426.8 14455.3 14490.6 14120.4 14131.0 14187.7 14214.3 14225.6 884.0 892.1 895.2 918.9 922.9 917.4 922.6 923.4 925.2 929.5 958.3 961.8 963.8 965.5 967.4 941.3 944.0 946.6 950.1 959.6 702.3 709.5 712.0 714.6 716.3 14340.9 14416.1 14425.8 14490.1 14604.9 14364.6 14484.5 14568.4 14670.1 14733.6 11595.8 11706.4 11708.5 11878.1 11931.0 3961.9 3993.9 4022.1 4031.1 4050.5 51758.7 51761.7 51799.0 51822.7 52010.5 10951.1 11124.2 11211.9 11397.4 11540.2 20273.0 20273.4 20311.8 20353.5 20409.4 7408.8 7414.2 7811.8 7858.0 8110.5 4329.5 4386.6 4443.7 4469.0 4502.3 3140.3 3156.3 3180.5 3183.3 3186.8 584.1 593.2 593.7 600.7 605.3 589.2 670.8 714.2 715.1 741.7 9023.2 9419.9 9540.2 9814.2 9938.3 690.8 770.7 777.4 809.3 833.1 4344.8 4507.4 4564.2 4565.3 4660.2 59591.0 59809.4 60038.0 60414.0 60484.0 51534.7 54199.2 54316.5 54345.5 54468.2 47200.8 47358.8 47848.3 49198.5 50095.7 8852.5 8872.8 8928.6 9195.8 9248.8 36193.8 36368.5 36493.0 37508.0 37674.2 41745.0 41972.6 47807.0 48022.0 48055.0 10911.8 11200.7 11698.4 11895.8 11942.9 11254.3 11918.6 12005.0 12100.0 14127.9 12457.9 12461.1 12606.3 12616.4 13038.9 13003.4 13115.5 13187.5 13624.1 13860.8 12634.5 12778.2 13072.9 13371.7 13472.9 9769.9 9801.9 9812.8 9962.6 10409.1 9983.1 10081.7 10548.3 10672.8 10681.0 16:36:27 INFO - PROCESS | 8171 | -------- Summary: end -------- 16:36:27 INFO - PROCESS | 8171 | 16:36:28 INFO - TEST-INFO | 8171: exit 0 16:36:28 INFO - TEST-OK | dromaeo_css | took 1122806ms 16:36:28 INFO - TEST-START | kraken 16:36:28 INFO - operating with platform_type : linux_ 16:36:28 INFO - Initialising browser for kraken test... 16:36:28 INFO - TEST-INFO | started process 8412 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQD9sWB/profile http://localhost:39841/getInfo.html) 16:36:37 INFO - PROCESS | 8412 | 16:36:37 INFO - PROCESS | 8412 | (process:8489): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:36:40 INFO - PROCESS | 8412 | __metrics Screen width/height:1600/1200 16:36:40 INFO - PROCESS | 8412 | colorDepth:24 16:36:40 INFO - PROCESS | 8412 | Browser inner width/height: 1024/697 16:36:40 INFO - PROCESS | 8412 | __metrics 16:36:42 INFO - PROCESS | 8412 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 16:36:45 INFO - TEST-INFO | 8412: exit 0 16:36:45 INFO - Browser initialized. 16:36:45 INFO - Running cycle 1/1 for kraken test... 16:36:45 INFO - TEST-INFO | started process 8539 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQD9sWB/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:36:46 INFO - PROCESS | 8539 | 16:36:46 INFO - PROCESS | 8539 | (process:8603): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:36:57 INFO - PROCESS | 8539 | RSS: Main: 141406208 16:36:57 INFO - PROCESS | 8539 | 16:36:59 INFO - PROCESS | 8539 | Cycle 1(1): loaded http://localhost:39841/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39841/tests/kraken/driver.html?testName=audio-beat-detection) 16:37:00 INFO - PROCESS | 8539 | RSS: Main: 146071552 16:37:00 INFO - PROCESS | 8539 | 16:37:02 INFO - PROCESS | 8539 | Cycle 1(1): loaded http://localhost:39841/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39841/tests/kraken/driver.html?testName=audio-dft) 16:37:03 INFO - PROCESS | 8539 | RSS: Main: 146153472 16:37:03 INFO - PROCESS | 8539 | 16:37:06 INFO - PROCESS | 8539 | Cycle 1(1): loaded http://localhost:39841/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39841/tests/kraken/driver.html?testName=audio-fft) 16:37:06 INFO - PROCESS | 8539 | RSS: Main: 145899520 16:37:06 INFO - PROCESS | 8539 | 16:37:08 INFO - PROCESS | 8539 | Cycle 1(1): loaded http://localhost:39841/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39841/tests/kraken/driver.html?testName=audio-oscillator) 16:37:09 INFO - PROCESS | 8539 | RSS: Main: 144969728 16:37:09 INFO - PROCESS | 8539 | 16:37:11 INFO - PROCESS | 8539 | Cycle 1(1): loaded http://localhost:39841/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39841/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:37:12 INFO - PROCESS | 8539 | RSS: Main: 145080320 16:37:12 INFO - PROCESS | 8539 | 16:37:15 INFO - PROCESS | 8539 | Cycle 1(1): loaded http://localhost:39841/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39841/tests/kraken/driver.html?testName=imaging-darkroom) 16:37:15 INFO - PROCESS | 8539 | RSS: Main: 147017728 16:37:15 INFO - PROCESS | 8539 | 16:37:19 INFO - PROCESS | 8539 | Cycle 1(1): loaded http://localhost:39841/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39841/tests/kraken/driver.html?testName=imaging-desaturate) 16:37:19 INFO - PROCESS | 8539 | RSS: Main: 146640896 16:37:19 INFO - PROCESS | 8539 | 16:37:22 INFO - PROCESS | 8539 | Cycle 1(1): loaded http://localhost:39841/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39841/tests/kraken/driver.html?testName=json-parse-financial) 16:37:23 INFO - PROCESS | 8539 | RSS: Main: 146444288 16:37:23 INFO - PROCESS | 8539 | 16:37:24 INFO - PROCESS | 8539 | Cycle 1(1): loaded http://localhost:39841/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39841/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:37:25 INFO - PROCESS | 8539 | RSS: Main: 146726912 16:37:25 INFO - PROCESS | 8539 | 16:37:26 INFO - PROCESS | 8539 | Cycle 1(1): loaded http://localhost:39841/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39841/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:37:27 INFO - PROCESS | 8539 | RSS: Main: 146624512 16:37:27 INFO - PROCESS | 8539 | 16:37:29 INFO - PROCESS | 8539 | Cycle 1(1): loaded http://localhost:39841/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39841/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:37:30 INFO - PROCESS | 8539 | RSS: Main: 147001344 16:37:30 INFO - PROCESS | 8539 | 16:37:32 INFO - PROCESS | 8539 | Cycle 1(1): loaded http://localhost:39841/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39841/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:37:33 INFO - PROCESS | 8539 | RSS: Main: 146358272 16:37:33 INFO - PROCESS | 8539 | 16:37:35 INFO - PROCESS | 8539 | Cycle 1(1): loaded http://localhost:39841/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39841/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:37:38 INFO - PROCESS | 8539 | RSS: Main: 145305600 16:37:38 INFO - PROCESS | 8539 | 16:37:39 INFO - PROCESS | 8539 | Cycle 1(1): loaded http://localhost:39841/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39841/tests/kraken/driver.html?testName=ai-astar) 16:37:40 INFO - PROCESS | 8539 | RSS: Main: 143740928 16:37:40 INFO - PROCESS | 8539 | 16:37:40 INFO - PROCESS | 8539 | __start_tp_report 16:37:40 INFO - PROCESS | 8539 | _x_x_mozilla_page_load 16:37:40 INFO - PROCESS | 8539 | _x_x_mozilla_page_load_details 16:37:40 INFO - PROCESS | 8539 | |i|pagename|runs| 16:37:40 INFO - PROCESS | 8539 | |0;ai-astar;113;105;109;109;110;119;110;109;108;111 16:37:40 INFO - PROCESS | 8539 | |1;audio-beat-detection;154;125;156;165;126;164;149;129;168;129 16:37:40 INFO - PROCESS | 8539 | |2;audio-dft;162;163;160;161;163;161;161;161;163;162 16:37:40 INFO - PROCESS | 8539 | |3;audio-fft;72;75;77;169;72;74;73;73;156;78 16:37:40 INFO - PROCESS | 8539 | |4;audio-oscillator;95;95;141;95;95;95;142;95;95;138 16:37:40 INFO - PROCESS | 8539 | |5;imaging-gaussian-blur;110;110;109;110;110;110;109;109;110;110 16:37:40 INFO - PROCESS | 8539 | |6;imaging-darkroom;147;152;147;146;147;148;147;146;147;146 16:37:40 INFO - PROCESS | 8539 | |7;imaging-desaturate;96;97;96;96;96;96;98;96;96;97 16:37:40 INFO - PROCESS | 8539 | |8;json-parse-financial;54;57;54;56;61;55;59;62;53;57 16:37:40 INFO - PROCESS | 8539 | |9;json-stringify-tinderbox;65;66;65;67;66;66;66;65;65;65 16:37:40 INFO - PROCESS | 8539 | |10;stanford-crypto-aes;77;78;80;87;85;78;79;79;78;79 16:37:40 INFO - PROCESS | 8539 | |11;stanford-crypto-ccm;113;120;114;112;115;110;119;115;116;127 16:37:40 INFO - PROCESS | 8539 | |12;stanford-crypto-pbkdf2;135;140;140;134;135;142;137;136;131;137 16:37:40 INFO - PROCESS | 8539 | |13;stanford-crypto-sha256-iterative;64;65;67;65;68;67;63;66;65;65 16:37:40 INFO - PROCESS | 8539 | __end_tp_report 16:37:40 INFO - PROCESS | 8539 | __start_cc_report 16:37:40 INFO - PROCESS | 8539 | _x_x_mozilla_cycle_collect,728 16:37:40 INFO - PROCESS | 8539 | __end_cc_report 16:37:40 INFO - PROCESS | 8539 | __startTimestamp1457311060161__endTimestamp 16:37:40 INFO - PROCESS | 8539 | 16:37:40 INFO - PROCESS | 8539 | ------- Summary: start ------- 16:37:40 INFO - PROCESS | 8539 | Number of tests: 14 16:37:40 INFO - PROCESS | 8539 | 16:37:40 INFO - PROCESS | 8539 | [#0] ai-astar Cycles:10 Average:110.30 Median:110.00 stddev:3.68 (3.3%) stddev-sans-first:3.77 16:37:40 INFO - PROCESS | 8539 | Values: 113.0 105.0 109.0 109.0 110.0 119.0 110.0 109.0 108.0 111.0 16:37:40 INFO - PROCESS | 8539 | 16:37:40 INFO - PROCESS | 8539 | [#1] audio-beat-detection Cycles:10 Average:146.50 Median:155.00 stddev:17.51 (11.3%) stddev-sans-first:18.36 16:37:40 INFO - PROCESS | 8539 | Values: 154.0 125.0 156.0 165.0 126.0 164.0 149.0 129.0 168.0 129.0 16:37:40 INFO - PROCESS | 8539 | 16:37:40 INFO - PROCESS | 8539 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 16:37:40 INFO - PROCESS | 8539 | Values: 162.0 163.0 160.0 161.0 163.0 161.0 161.0 161.0 163.0 162.0 16:37:40 INFO - PROCESS | 8539 | 16:37:40 INFO - PROCESS | 8539 | [#3] audio-fft Cycles:10 Average:91.90 Median:73.50 stddev:37.39 (50.9%) stddev-sans-first:38.96 16:37:40 INFO - PROCESS | 8539 | Values: 72.0 75.0 77.0 169.0 72.0 74.0 73.0 73.0 156.0 78.0 16:37:40 INFO - PROCESS | 8539 | 16:37:40 INFO - PROCESS | 8539 | [#4] audio-oscillator Cycles:10 Average:108.60 Median:95.00 stddev:21.92 (23.1%) stddev-sans-first:22.69 16:37:40 INFO - PROCESS | 8539 | Values: 95.0 95.0 141.0 95.0 95.0 95.0 142.0 95.0 95.0 138.0 16:37:40 INFO - PROCESS | 8539 | 16:37:40 INFO - PROCESS | 8539 | [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 16:37:40 INFO - PROCESS | 8539 | Values: 110.0 110.0 109.0 110.0 110.0 110.0 109.0 109.0 110.0 110.0 16:37:40 INFO - PROCESS | 8539 | 16:37:40 INFO - PROCESS | 8539 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:1.77 (1.2%) stddev-sans-first:1.87 16:37:40 INFO - PROCESS | 8539 | Values: 147.0 152.0 147.0 146.0 147.0 148.0 147.0 146.0 147.0 146.0 16:37:40 INFO - PROCESS | 8539 | 16:37:40 INFO - PROCESS | 8539 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 16:37:40 INFO - PROCESS | 8539 | Values: 96.0 97.0 96.0 96.0 96.0 96.0 98.0 96.0 96.0 97.0 16:37:40 INFO - PROCESS | 8539 | 16:37:40 INFO - PROCESS | 8539 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:57.00 stddev:3.05 (5.3%) stddev-sans-first:3.06 16:37:40 INFO - PROCESS | 8539 | Values: 54.0 57.0 54.0 56.0 61.0 55.0 59.0 62.0 53.0 57.0 16:37:40 INFO - PROCESS | 8539 | 16:37:40 INFO - PROCESS | 8539 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 16:37:40 INFO - PROCESS | 8539 | Values: 65.0 66.0 65.0 67.0 66.0 66.0 66.0 65.0 65.0 65.0 16:37:40 INFO - PROCESS | 8539 | 16:37:40 INFO - PROCESS | 8539 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:79.00 stddev:3.30 (4.2%) stddev-sans-first:3.32 16:37:40 INFO - PROCESS | 8539 | Values: 77.0 78.0 80.0 87.0 85.0 78.0 79.0 79.0 78.0 79.0 16:37:40 INFO - PROCESS | 8539 | 16:37:40 INFO - PROCESS | 8539 | [#11] stanford-crypto-ccm Cycles:10 Average:116.10 Median:115.50 stddev:4.86 (4.2%) stddev-sans-first:5.03 16:37:40 INFO - PROCESS | 8539 | Values: 113.0 120.0 114.0 112.0 115.0 110.0 119.0 115.0 116.0 127.0 16:37:40 INFO - PROCESS | 8539 | 16:37:40 INFO - PROCESS | 8539 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.70 Median:137.00 stddev:3.27 (2.4%) stddev-sans-first:3.41 16:37:40 INFO - PROCESS | 8539 | Values: 135.0 140.0 140.0 134.0 135.0 142.0 137.0 136.0 131.0 137.0 16:37:40 INFO - PROCESS | 8539 | 16:37:40 INFO - PROCESS | 8539 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:65.50 stddev:1.51 (2.3%) stddev-sans-first:1.50 16:37:40 INFO - PROCESS | 8539 | Values: 64.0 65.0 67.0 65.0 68.0 67.0 63.0 66.0 65.0 65.0 16:37:40 INFO - PROCESS | 8539 | -------- Summary: end -------- 16:37:40 INFO - PROCESS | 8539 | 16:37:48 INFO - Browser shutdown timed out after 5 seconds, terminating process. 16:37:48 INFO - Terminating psutil.Process(pid=8539, name='firefox') 16:37:53 INFO - PROCESS | 8539 | [Child 8603] WARNING: pipe error (3): Connection reset by peer: file /builds/slave/m-aurora-l64-00000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_posix.cc, line 459 16:37:53 INFO - PROCESS | 8539 | [Child 8603] ###!!! ABORT: Aborting on channel error.: file /builds/slave/m-aurora-l64-00000000000000000/build/src/ipc/glue/MessageChannel.cpp, line 1857 16:37:53 INFO - PROCESS | 8539 | [Child 8603] ###!!! ABORT: Aborting on channel error.: file /builds/slave/m-aurora-l64-00000000000000000/build/src/ipc/glue/MessageChannel.cpp, line 1857 16:37:53 INFO - TEST-INFO | 8539: exit 9 16:38:21 INFO - TEST-OK | kraken | took 112817ms 16:38:21 INFO - TEST-START | v8_7 16:38:21 INFO - operating with platform_type : linux_ 16:38:21 INFO - Initialising browser for v8_7 test... 16:38:21 INFO - TEST-INFO | started process 8831 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8SYKNj/profile http://localhost:39841/getInfo.html) 16:38:31 INFO - PROCESS | 8831 | 16:38:31 INFO - PROCESS | 8831 | (process:8909): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:38:33 INFO - PROCESS | 8831 | __metrics Screen width/height:1600/1200 16:38:33 INFO - PROCESS | 8831 | colorDepth:24 16:38:33 INFO - PROCESS | 8831 | Browser inner width/height: 1024/697 16:38:33 INFO - PROCESS | 8831 | __metrics 16:38:34 INFO - PROCESS | 8831 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 16:38:38 INFO - TEST-INFO | 8831: exit 0 16:38:38 INFO - Browser initialized. 16:38:38 INFO - Running cycle 1/1 for v8_7 test... 16:38:38 INFO - TEST-INFO | started process 8958 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8SYKNj/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:38:39 INFO - PROCESS | 8958 | 16:38:39 INFO - PROCESS | 8958 | (process:9022): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:38:50 INFO - PROCESS | 8958 | RSS: Main: 141201408 16:38:50 INFO - PROCESS | 8958 | 16:39:12 INFO - PROCESS | 8958 | Cycle 1(1): loaded http://localhost:39841/tests/v8_7/run.html (next: http://localhost:39841/tests/v8_7/run.html) 16:39:12 INFO - PROCESS | 8958 | RSS: Main: 144961536 16:39:12 INFO - PROCESS | 8958 | 16:39:12 INFO - PROCESS | 8958 | __start_tp_report 16:39:12 INFO - PROCESS | 8958 | _x_x_mozilla_page_load 16:39:12 INFO - PROCESS | 8958 | _x_x_mozilla_page_load_details 16:39:12 INFO - PROCESS | 8958 | |i|pagename|runs| 16:39:12 INFO - PROCESS | 8958 | |0;Richards;170.94017094017093 16:39:12 INFO - PROCESS | 8958 | |1;DeltaBlue;168.01075268817203 16:39:12 INFO - PROCESS | 8958 | |2;Encrypt;278.70680044593087 16:39:12 INFO - PROCESS | 8958 | |3;Decrypt;5208.333333333333 16:39:12 INFO - PROCESS | 8958 | |4;RayTrace;909.0909090909091 16:39:12 INFO - PROCESS | 8958 | |5;Earley;569.4760820045558 16:39:12 INFO - PROCESS | 8958 | |6;Boyer;11076.923076923076 16:39:12 INFO - PROCESS | 8958 | |7;RegExp;38980.769230769234 16:39:12 INFO - PROCESS | 8958 | |8;Splay;545.0108459869848 16:39:12 INFO - PROCESS | 8958 | |9;NavierStokes;4854.368932038835 16:39:12 INFO - PROCESS | 8958 | __end_tp_report 16:39:12 INFO - PROCESS | 8958 | __startTimestamp1457311152695__endTimestamp 16:39:12 INFO - PROCESS | 8958 | 16:39:12 INFO - PROCESS | 8958 | ------- Summary: start ------- 16:39:12 INFO - PROCESS | 8958 | Number of tests: 10 16:39:12 INFO - PROCESS | 8958 | 16:39:12 INFO - PROCESS | 8958 | [#0] Richards Cycles:1 Average:170.94 Median:170.94 stddev:0.00 (0.0%) 16:39:12 INFO - PROCESS | 8958 | Values: 170.9 16:39:12 INFO - PROCESS | 8958 | 16:39:12 INFO - PROCESS | 8958 | [#1] DeltaBlue Cycles:1 Average:168.01 Median:168.01 stddev:0.00 (0.0%) 16:39:12 INFO - PROCESS | 8958 | Values: 168.0 16:39:12 INFO - PROCESS | 8958 | 16:39:12 INFO - PROCESS | 8958 | [#2] Encrypt Cycles:1 Average:278.71 Median:278.71 stddev:0.00 (0.0%) 16:39:12 INFO - PROCESS | 8958 | Values: 278.7 16:39:12 INFO - PROCESS | 8958 | 16:39:12 INFO - PROCESS | 8958 | [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 16:39:12 INFO - PROCESS | 8958 | Values: 5208.3 16:39:12 INFO - PROCESS | 8958 | 16:39:12 INFO - PROCESS | 8958 | [#4] RayTrace Cycles:1 Average:909.09 Median:909.09 stddev:0.00 (0.0%) 16:39:12 INFO - PROCESS | 8958 | Values: 909.1 16:39:12 INFO - PROCESS | 8958 | 16:39:12 INFO - PROCESS | 8958 | [#5] Earley Cycles:1 Average:569.48 Median:569.48 stddev:0.00 (0.0%) 16:39:12 INFO - PROCESS | 8958 | Values: 569.5 16:39:12 INFO - PROCESS | 8958 | 16:39:12 INFO - PROCESS | 8958 | [#6] Boyer Cycles:1 Average:11076.92 Median:11076.92 stddev:0.00 (0.0%) 16:39:12 INFO - PROCESS | 8958 | Values: 11076.9 16:39:12 INFO - PROCESS | 8958 | 16:39:12 INFO - PROCESS | 8958 | [#7] RegExp Cycles:1 Average:38980.77 Median:38980.77 stddev:0.00 (0.0%) 16:39:12 INFO - PROCESS | 8958 | Values: 38980.8 16:39:12 INFO - PROCESS | 8958 | 16:39:12 INFO - PROCESS | 8958 | [#8] Splay Cycles:1 Average:545.01 Median:545.01 stddev:0.00 (0.0%) 16:39:12 INFO - PROCESS | 8958 | Values: 545.0 16:39:12 INFO - PROCESS | 8958 | 16:39:12 INFO - PROCESS | 8958 | [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 16:39:12 INFO - PROCESS | 8958 | Values: 4854.4 16:39:12 INFO - PROCESS | 8958 | -------- Summary: end -------- 16:39:12 INFO - PROCESS | 8958 | 16:39:14 INFO - TEST-INFO | 8958: exit 0 16:39:14 INFO - TEST-OK | v8_7 | took 52512ms 16:39:14 INFO - SUITE-END | took 1288s 16:39:14 INFO - Completed test suite (00:21:28) 16:39:14 INFO - Working with test: dromaeo_css 16:39:14 INFO - Generating results file: dromaeo_css 16:39:14 INFO - Working with test: kraken 16:39:14 INFO - Generating results file: kraken 16:39:14 INFO - javascript benchmark 16:39:14 INFO - Working with test: v8_7 16:39:14 INFO - Generating results file: v8_7 16:39:14 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:39:14 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 16:39:14 INFO - process_Request line: dromaeo_css 7423.12 graph.html#tests=[[72,52,43]] 16:39:14 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:39:14 INFO - process_Request line: kraken 1493.10 graph.html#tests=[[232,52,43]] 16:39:14 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:39:14 INFO - process_Request line: v8_7 21919.28 graph.html#tests=[[230,52,43]] 16:39:14 INFO - RETURN: dromaeo_css: 7423.12 16:39:14 INFO - RETURN: kraken: 1493.10 16:39:14 INFO - RETURN: v8_7: 21919.28 16:39:14 INFO - javascript benchmark 16:39:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3360.5967283925916, 3376.5104059911328, 3401.1667141550356, 3411.9488207676873, 3417.1798768295585, 5531.115021596545, 5536.446355364462, 5551.666899986004, 5555.3611334696525, 5565.1374037024225, 5528.5024347808685, 5592.748326325315, 5610.607257491977, 5638.915416268739, 5677.914831277534, 5063.8480845574695, 5081.542661160494, 5170.431252562215, 5171.327727395434, 5178.378594568639, 4895.069936712031, 4985.576226020775, 5035.395752509704, 5098.26075219093, 5100.464451232623, 5032.647714659957, 5063.291139240509, 5157.690538567679, 5159.819406320779, 5166.638335316529, 5040.0, 5042.865355295066, 5056.81164926242, 5078.97460512695, 5096.541311281965, 4930.926036109426, 4946.183879659852, 4980.576650984671, 4992.951480189165, 5031.4465408805, 5317.202419637047, 5330.440303768126, 5390.946090539083, 5405.486478784548, 5423.240746295522, 5814.592978491507, 5819.883602327972, 5890.587658863881, 5898.823035308905, 5906.616069955439, 5816.360200377955, 5850.444207800252, 5868.2371291732225, 5959.463648271676, 5985.191999080155, 5563.693996830132, 5565.499105080562, 5569.665820050729, 5576.9163462548095, 5592.356878958931, 6035.849103772441, 6048.4858787003595, 6055.455009049207, 6057.939420605826, 6064.0, 5678.545716342683, 5734.684592347461, 5795.8551036224435, 5796.62321949072, 5914.0, 5908.970455147697, 5910.911336329958, 5923.970380148072, 5927.940720592739, 5939.46544810969, 5874.206982057453, 5878.265216847894, 5879.794207202727, 5892.0, 5894.587378883522, 5809.186713860063, 5852.356240813507, 5875.177475153482, 5935.821925342247, 5943.435373639497, 4439.866803995886, 4441.089576636782, 4448.288273876165, 4450.799714012877, 4469.754163520973, 4020.6984476164403, 4028.0, 4031.677465802729, 4039.6970227233073, 4075.612816782401, 5608.69152196625, 5630.493255607015, 5667.1782591524825, 5708.20085188074, 5737.340205876294, 5837.94162058374, 5893.410658934158, 5905.084711869667, 5909.113632955005, 5914.290285165807, 5474.124140137559, 5525.309336332958, 5585.972070139624, 5615.410381909841, 5635.0702134147405, 5028.924566131511, 5151.407588127413, 5152.793888244429, 5159.845204643867, 5196.53231209193, 6029.909551356734, 6056.273247210363, 6069.180660610761, 6090.36051214625, 6098.847528811638, 5865.0, 5939.376365481562, 5959.73181206838, 5968.283805943314, 5975.193348897843, 6033.336333003454, 6053.909191362045, 6091.0, 6094.878102437838, 6106.816795496142, 5864.912026319524, 5876.147958546072, 5899.4985426239255, 5910.674912879833, 5914.881702366015, 5915.171875937458, 5984.162217289496, 5987.371326010706, 5995.760169593167, 6007.189029481139, 5797.710114494343, 5812.622179558315, 5825.126231065374, 5854.356020837789, 5890.558208134321, 5824.21373114641, 5846.912296315644, 5857.238558987475, 5863.677497737665, 5877.853053673693, 5607.355154157324, 5622.184783206494, 5655.4344565543115, 5663.093904975184, 5701.572382071278, 5733.140028995684, 5814.825555233349, 5909.113632954919, 5925.496332811759, 5959.493443057216, 5705.34388545306, 5725.08398656213, 5739.971300143473, 5741.0527263002805, 5764.423557644202], "unit": "score", "name": "dojo.html", "value": 5469.2777124046925}, {"lowerIsBetter": false, "replicates": [554.3984776517478, 560.3639868748969, 579.6811753535552, 581.549299293048, 603.9822898416172, 31830.20424489389, 32412.67587324126, 39827.800860995725, 39965.0, 40189.19621607566, 45468.77265613675, 46159.0, 46334.07331853361, 46383.536164638346, 46489.30266046012, 9022.233110185642, 9187.310951678617, 9230.0, 9246.26029917605, 9256.120668536478, 8849.07084756101, 8930.86603700945, 8949.149830766068, 8967.46195228285, 8985.550722463851, 8907.554622268894, 8955.641774329019, 8983.10168983103, 8984.46093234408, 8991.3256505762, 8906.332025098143, 8910.064443233465, 8944.597493112826, 8988.59551320192, 9036.45781253127, 8889.377743557954, 9021.819563608757, 9023.4134781239, 9032.593533291018, 9049.457032578066, 42334.36498452526, 42574.78712606417, 42629.78685106586, 42708.0, 42964.78517607392, 3704.759190652626, 3740.9064773380883, 3893.805309734502, 4296.334068219399, 4421.977890110561, 28511.0, 28529.286767830763, 28708.282292942844, 30838.691613083807, 34076.0, 4214.683898707579, 4358.956410435919, 4366.08312254427, 4383.728414403546, 4436.44544431946, 219378.0, 219823.0, 220115.0, 408245.0, 419967.9001605003, 64875.0, 65285.0, 65708.0, 66360.0, 66530.66734666392, 68524.0, 69078.0, 69120.0, 69132.654336728, 69266.307336927, 15858.127802970947, 16068.35726570924, 16160.676786464204, 16204.75692864608, 16210.513684589481, 11981.400929953468, 11991.580294689644, 12027.819582706266, 12049.397530123459, 12110.878891211152, 21968.89015554912, 22145.446363841034, 22186.44533886666, 22338.21816236424, 22367.10531578751, 8653.956730216309, 8721.825563488695, 8745.0, 8826.382153249338, 8911.50986695725, 1015.6673142953678, 1051.7055224537141, 1101.8181999970075, 1177.0465922602718, 1179.3808250668296, 29926.25184370408, 29989.850050749606, 30658.846705766773, 30743.692563074084, 31209.531857022164, 1126.8591426071741, 1137.3573930729112, 1152.654203738875, 1204.5663561118165, 1218.6465924881861, 15383.384664613513, 16155.273012714457, 17698.734518981968, 17721.202545885466, 18705.064746762608, 531597.0, 532738.0, 539726.0, 543691.0, 546298.0, 55640.16539751907, 55960.440395596335, 56130.43869561252, 56131.158032629544, 56169.43830561724, 1451.397669966973, 1464.5899148238511, 1489.0990950474807, 1494.6637006673411, 1500.8424115467938, 32393.514097288087, 32775.50836737498, 33009.0, 33055.0, 33141.337173256885, 48894.51105489042, 49900.75049624729, 49930.75034624804, 49960.50118496451, 50001.49998499968, 328647.0, 329091.0, 329881.0, 330221.0, 330713.0, 34154.65845341515, 45687.0, 47808.04383912233, 48182.0, 48412.03175936391, 47137.76431117822, 47847.0, 47855.0, 48228.758856205495, 48555.27167092567, 39504.407433887936, 39656.0, 39954.40068398918, 40115.79942100271, 40507.0, 40912.38631420471, 41444.79277603592, 42558.148837023706, 43067.87581181743, 46234.768826157, 39711.0, 40896.0, 41022.17955640811, 41180.0, 41372.0, 34654.0, 35019.824900875334, 35612.28775424529, 35798.46302305415, 35980.820095899355, 27238.182854514398, 27709.861450693425, 27764.861175693994, 27971.58042629403, 28012.159635210977], "unit": "score", "name": "ext.html", "value": 20475.058744702084}, {"lowerIsBetter": false, "replicates": [375.6975634614136, 377.0573566084788, 383.29091181314556, 383.33874067234007, 385.6933737678543, 15719.685606287896, 16114.838851611481, 17632.030238336887, 18303.627227957924, 18375.44873653789, 14603.488877889276, 16995.915020424913, 17096.401625943094, 17868.55328616785, 17917.193726282316, 5092.465291144441, 5385.3537575491, 5779.393163717791, 5820.806734619414, 5836.0, 5277.419483856773, 5439.972800135994, 5459.890802183954, 5729.28383952006, 5822.650640961535, 5111.948880511203, 5247.685138891659, 5411.675299482024, 5456.399796022434, 5469.179623056533, 5492.670439773627, 5499.175123731432, 5518.889622207554, 5521.4478552144865, 5522.22688823563, 5222.63441559091, 5540.2243685884005, 5549.306336707911, 5553.111502159675, 5557.805476808333, 20914.268000619904, 20941.685874711893, 21514.354569362946, 21535.67696484554, 21685.891570542204, 2180.7056047433553, 2220.0, 2255.3572231913827, 2282.600544904635, 2377.6314671225987, 10433.21750868688, 10675.41285229312, 10786.191035672278, 11448.599299024494, 14326.068805527711, 1897.7532920720357, 1918.88486690799, 1919.299455698674, 1944.3680803738841, 1962.705594160873, 57686.71156644232, 59533.7023314885, 60136.0, 60411.697941510014, 61168.694156529375, 10582.365058096539, 10902.236843421044, 10908.509117089592, 11010.064144547803, 11034.668959931216, 14633.195174265305, 14700.0, 14703.191324477042, 14776.48282310114, 14784.556463306119, 7927.762167134995, 7942.324902383247, 8040.15578364275, 8043.356531477468, 8071.313938315191, 7605.277498637731, 7659.731909383257, 7662.5402475850515, 7692.384609231248, 7702.499337543042, 4316.503602085738, 4532.481618657786, 4731.2903064539905, 4779.713217206979, 4842.055799119138, 1926.7784204816346, 1995.30164442444, 2004.7193392925003, 2014.0735261779746, 2043.7956204379443, 982.6118683120128, 1003.172382784206, 1036.8789942273659, 1084.8535447714457, 1086.02257967828, 16503.33986640521, 16521.173941302888, 16678.499645010426, 16878.409255675993, 17560.121993900255, 974.4104816586005, 1010.3786171504619, 1061.3260579531898, 1087.3739918097863, 1118.6588090632272, 8363.916360836436, 10403.58385664565, 10419.426931518688, 10544.26190166681, 10638.361698298128, 565191.5221271684, 588084.0, 588105.0, 588843.0, 600231.0, 72997.6350118246, 73467.0, 74639.0, 76465.0, 77604.0, 1144.7252659361693, 1167.795635763738, 1173.8180582009802, 1184.4018770520831, 1198.8621308549627, 16061.75907361414, 16086.356545738508, 16271.186440677682, 16467.176641167654, 16570.254338554554, 32863.178420539676, 34270.828645856614, 34549.827250863586, 34935.475967859995, 35242.64757352394, 38303.654081602006, 42952.78523607362, 45090.77454612706, 45246.321305179794, 45353.31970020518, 8090.878636820335, 8276.08963014056, 8381.49711017341, 8412.579371031301, 8425.83148337042, 11327.490262938023, 11353.602623908124, 11546.0, 12157.69605759863, 12275.75448491043, 9920.355176913477, 10849.240553161202, 11023.283486573348, 11055.447227638426, 11389.373584452935, 10452.529636166542, 11027.61403350879, 11077.778444430905, 11352.148588856035, 11488.080953523531, 9905.455199964072, 10720.35677859331, 10758.73103172427, 11042.33745975244, 11045.005949464587, 8345.707900223462, 8550.273226775793, 8555.144485551395, 8562.828743425222, 8633.8704919425, 9745.415275083518, 10201.38791672502, 10337.431441270803, 10418.583256669648, 10500.737481562717], "unit": "score", "name": "jquery.html", "value": 8753.266144439029}, {"lowerIsBetter": false, "replicates": [1506.4426162319944, 1514.4320879670124, 1705.624762552238, 1841.7513635659182, 1851.6204178143482, 8376.62305196266, 8385.790355241123, 8493.78765530862, 8573.914260857397, 8582.442141260814, 8470.152984701526, 8489.193526614961, 8600.268977136935, 8640.0, 8643.611037503311, 2435.220729366599, 2461.4215659320043, 2465.878025498403, 2467.222824810188, 2472.938176545583, 2445.877706114696, 2485.5526005319034, 2520.1179587144443, 2520.155747824481, 2524.0408644714985, 2144.07804644003, 2185.868847869133, 2398.052769156191, 2417.7703118203744, 2432.72023717273, 2407.5786737320987, 2415.070197973775, 2427.8786060696893, 2428.76926691964, 2437.244454219198, 2360.5160942006846, 2372.41875740443, 2390.7131144262626, 2403.3510952042852, 2408.157144999254, 8417.158284171595, 8444.113368096323, 8471.872921906177, 8495.915040849573, 8509.489430634181, 4994.725290109042, 5162.638615296931, 5169.534741873212, 5173.896522069537, 5193.714345710984, 3229.0958531611186, 3244.448443764542, 3261.4455542557585, 3285.195127193853, 3316.950245746316, 1107.9667609971714, 1108.6563165418745, 1117.3351855645878, 1132.2300835431904, 1157.5254145800182, 11961.162718609701, 11971.281723096556, 11987.861153190346, 11995.760084798343, 12031.097667674872, 4463.35281384204, 4541.5940279826245, 4577.267637178035, 4581.427321584802, 4600.907981840412, 9513.762155946019, 9569.473678947725, 9592.95203523978, 9627.181689556326, 9638.180754635794, 5001.174806157016, 5004.574611158092, 5016.2224855147515, 5034.370703662043, 5036.722980236123, 4546.090781843644, 4572.382728331632, 4579.862604121881, 4622.399088118523, 4631.421072365954, 3753.793541355252, 3777.6788972937607, 3795.6014618465215, 3801.334766415866, 3841.980790096032, 1115.654147214366, 1139.9487023083982, 1149.1955631058127, 1157.4039369724599, 1173.342927960345, 1083.9295445796, 1145.0782120392996, 1148.7128217945515, 1155.7861795567846, 1230.028277660638, 7745.186755390716, 7861.606919653995, 7887.2112788721815, 7969.924060251908, 7975.60121993898, 1101.1851230089676, 1139.5214010115772, 1146.6502716671496, 1170.1399471388522, 1173.3253379306761, 6040.456358927718, 6083.8479038023515, 6162.691865406712, 6174.722137503823, 6192.133101365813, 9919.206463482904, 10507.737306567396, 10514.474276286155, 10557.9472102639, 10620.09729173029, 10214.489275536194, 10283.794324113476, 10320.329178603366, 10322.793544129076, 10410.167186625053, 8048.356131509465, 8089.757307280791, 8091.595420228965, 8112.310453611509, 8160.714374996846, 7634.885476717743, 7658.770236892902, 7700.961495192488, 7748.728794492165, 7875.291223789886, 9298.488583127993, 9322.580483878377, 9405.341626086109, 9459.716208513755, 9465.0, 9371.625134994523, 9382.624695012122, 9401.482918439278, 9456.101670341306, 9494.810103797747, 7549.886751698838, 7679.539227646359, 7680.884786728316, 7748.031496062992, 7771.106322772727, 8061.677532898619, 8175.427720059539, 8203.179682031749, 8210.261076503144, 8213.301869341172, 7841.607919603883, 7879.803004924923, 7934.841303174019, 7974.202579742211, 8098.0, 6820.147481564804, 7026.718931242693, 7427.740029098955, 7451.962740186264, 7489.28851759082, 7288.781336559911, 7344.742933997284, 7361.227071157666, 7391.0761154855645, 7418.517796343221, 6879.449644028566, 6951.687174077279, 6953.826154346182, 6958.06066181059, 6983.790486285419, 6807.591544507345, 6820.147481564804, 6836.93163068363, 6855.0, 6857.657117144223], "unit": "score", "name": "mootools.html", "value": 4826.235775920499}, {"lowerIsBetter": false, "replicates": [363.14841696222356, 363.92903383840127, 366.5849819695973, 369.08651088555825, 372.19791349641497, 6367.235931688198, 6425.100485931974, 6446.228121907584, 6474.384933431323, 6512.3487651234855, 6377.489800815935, 6381.393767592083, 6382.457491113261, 6407.263164736057, 6429.485641148709, 4900.387451568554, 4929.668989372876, 4932.975335123319, 4936.481669424713, 4946.7526623668855, 4937.876553086166, 4938.80244790208, 4945.975270123644, 4948.2330238812865, 4948.307236986825, 4701.48283688794, 4757.571818536331, 4814.350062741538, 4814.687045342059, 4830.6135509159185, 4788.976055119737, 4810.422749270093, 4812.783424745895, 4827.372441582607, 4829.613630909519, 4233.809478573472, 4237.237297286487, 4241.533431322583, 4243.384709217177, 4251.638610718092, 5963.105534169866, 6005.699715014275, 6042.244719410074, 6053.031514957585, 6053.4551890330085, 5593.52455041322, 5696.202531645573, 5706.3722990471015, 5720.628159169641, 5731.942680573225, 6706.429953453913, 6752.729890804362, 6759.0, 6775.864482710367, 6776.457883369319, 4728.621710263171, 4737.928931066037, 4746.430428348585, 4756.904861902743, 4765.666403351766, 6927.653617319113, 6962.930370696279, 6999.895001574981, 7047.189573199096, 7080.150381954199, 4845.3216549683075, 4859.392575928009, 4870.95129048705, 4882.340883980617, 4883.0, 4883.243097319921, 4928.334674818853, 4934.284528743384, 4939.456659767423, 4945.9258111128365, 5676.233708449389, 5694.743736531783, 5697.914531282034, 5699.059655156852, 5705.71471426427, 6645.501587380966, 6792.252852186256, 6792.796216113525, 6842.897356539655, 6855.0, 1724.3275122702157, 1744.8516876065423, 1745.7555942168106, 1747.2923465996037, 1750.6673731990882, 1161.8605767307808, 1171.9941400292944, 1175.9588414405455, 1180.7520420711746, 1183.47335435732, 6534.4445722113205, 6564.704588293538, 6576.5067619928695, 6597.901031484532, 6606.6036037837885, 7047.929520704727, 7059.682314295869, 7069.363757261871, 7070.257622949516, 7086.0, 6453.677316134174, 6512.902306465407, 6552.180977377828, 6589.505787065989, 6632.602043877383, 3814.256220037066, 3835.0412396900774, 3845.250176215611, 3854.6338097880657, 3856.0, 7277.417806575567, 7281.5631062136445, 7282.235365286675, 7292.635368231673, 7293.380062694624, 7080.433565314763, 7235.131784185826, 7263.527870688388, 7269.127704675367, 7272.890906636405, 7269.0, 7274.927250727531, 7283.126024876943, 7284.34121545632, 7286.526375785557, 7060.576365418091, 7064.399526040344, 7072.08062951813, 7075.327843854826, 7115.501914865909, 6788.117544719353, 6995.580265183901, 7007.474439416962, 7016.789496315118, 7050.400715939202, 7250.709971601077, 7279.090113735783, 7305.525140865827, 7317.963410182915, 7328.230535793665, 4868.172410690262, 4934.802607895787, 4936.629752768628, 4942.8022879085875, 4948.703077815343, 6934.375906168469, 7116.893246601202, 7120.216776154515, 7131.965864949657, 7142.642867856483, 6900.447964162755, 6930.549514281555, 6936.098307220029, 6958.965205173941, 6962.885938249856, 6670.566413183322, 6830.45356371499, 6836.623985680835, 6862.107925969792, 6894.931050689429, 6730.192376914802, 6782.287859774653, 6789.219239787488, 6795.28649491816, 6800.183977922681, 6910.619915904674, 6942.479314051366, 6950.339717726808, 6957.721691132298, 6963.423533292714, 6606.10817539626, 6741.258461569126, 6745.797626071226, 6752.324767523209, 6753.0], "unit": "score", "name": "prototype.html", "value": 5157.438442008254}, {"lowerIsBetter": false, "replicates": [769.569041336851, 790.2650535002446, 821.9465734727243, 911.7766147293912, 939.0797018921456, 14252.857471425283, 14407.927960360183, 14426.783598246035, 14455.349509272068, 14490.5652830415, 14120.364583593737, 14131.0, 14187.716245675107, 14214.289285535733, 14225.644358891033, 883.9558022098886, 892.054422312351, 895.1630225738922, 918.9081091890824, 922.9400088994228, 917.4082716647758, 922.575615217001, 923.3674932671108, 925.1719710858811, 929.4748467116058, 958.3435346787472, 961.7643677299071, 963.8457846744523, 965.5172413793103, 967.4147140979711, 941.3081385181886, 943.9811203775955, 946.6024269806663, 950.116391755667, 959.6161535385831, 702.3117345001875, 709.4856229233816, 712.0316369737153, 714.5748279773527, 716.3051839715467, 14340.92829535856, 14416.062955907832, 14425.78361324581, 14490.130592164398, 14604.853951460456, 14364.64088397788, 14484.49304274356, 14568.417263309455, 14670.119792812466, 14733.55799326022, 11595.768084638345, 11706.414679266089, 11708.53165873364, 11878.109141814399, 11931.0, 3961.861334853295, 3993.900152496182, 4022.0950286185375, 4031.1333063391216, 4050.4936882889638, 51758.74120629411, 51761.74119129418, 51799.0, 51822.74088629533, 52010.479895200944, 10951.123910087173, 11124.221304508768, 11211.943940280247, 11397.373144477133, 11540.192186547029, 20273.0, 20273.391798246077, 20311.796882031285, 20353.473489488348, 20409.387718368474, 7408.814779630445, 7414.184439711627, 7811.843763124706, 7857.960710196527, 8110.513369197749, 4329.458817647794, 4386.561343865588, 4443.688941774045, 4469.039156581351, 4502.3471596618965, 3140.262038420969, 3156.337169194495, 3180.507021411685, 3183.3474137801695, 3186.7928584641922, 584.1354794903482, 593.2406519654849, 593.7476572456688, 600.7386786747778, 605.2827399531569, 589.2310534752189, 670.792054463118, 714.2179313651543, 715.1204019056589, 741.7181471040969, 9023.187913087853, 9419.858702119474, 9540.189083927944, 9814.214862810957, 9938.254630902711, 690.7582346178797, 770.7186876790043, 777.3819813248481, 809.2756982500747, 833.1044127562894, 4344.804483798237, 4507.3689683444345, 4564.246899261651, 4565.292379681155, 4660.184467718136, 59591.0, 59809.401905981256, 60038.0, 60414.0, 60484.0, 51534.74232628813, 54199.187012194845, 54316.45683543193, 54345.45654543404, 54468.182977255376, 47200.76399618049, 47358.76320618375, 47848.282275765894, 49198.50801491939, 50095.74952125216, 8852.513111778913, 8872.778180545538, 8928.642854285756, 9195.77010574741, 9248.768780780534, 36193.81903090573, 36368.45447318239, 36493.0, 37508.0, 37674.246515069, 41745.0, 41972.580274196866, 47807.0, 48022.0, 48055.0, 10911.78176436451, 11200.719982000515, 11698.35659038761, 11895.82156267674, 11942.940285298519, 11254.324740515594, 11918.642440726791, 12005.039596832406, 12100.0, 14127.929360353133, 12457.875421245672, 12461.133581083635, 12606.306653134166, 12616.432260548114, 13038.934805326293, 13003.414846331749, 13115.475380984653, 13187.477995249164, 13624.114432561852, 13860.792088118887, 12634.494620215457, 12778.169418988107, 13072.934635326763, 13371.665708357368, 13472.932635336761, 9769.853452198366, 9801.9019809801, 9812.754681133028, 9962.55168517404, 10409.115225205942, 9983.066922897406, 10081.69754907354, 10548.261621686408, 10672.786544269227, 10681.03870651645], "unit": "score", "name": "yui.html", "value": 6856.702275120074}], "name": "dromaeo_css", "value": 7423.122791497448}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 105.0, 109.0, 109.0, 110.0, 119.0, 110.0, 109.0, 108.0, 111.0], "unit": "score", "name": "ai-astar", "value": 110.3}, {"lowerIsBetter": true, "replicates": [154.0, 125.0, 156.0, 165.0, 126.0, 164.0, 149.0, 129.0, 168.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 146.5}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 160.0, 161.0, 163.0, 161.0, 161.0, 161.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [72.0, 75.0, 77.0, 169.0, 72.0, 74.0, 73.0, 73.0, 156.0, 78.0], "unit": "score", "name": "audio-fft", "value": 91.9}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 141.0, 95.0, 95.0, 95.0, 142.0, 95.0, 95.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 108.6}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 109.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [147.0, 152.0, 147.0, 146.0, 147.0, 148.0, 147.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.3}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 98.0, 96.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [54.0, 57.0, 54.0, 56.0, 61.0, 55.0, 59.0, 62.0, 53.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 56.8}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 65.0, 67.0, 66.0, 66.0, 66.0, 65.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.6}, {"lowerIsBetter": true, "replicates": [77.0, 78.0, 80.0, 87.0, 85.0, 78.0, 79.0, 79.0, 78.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.0}, {"lowerIsBetter": true, "replicates": [113.0, 120.0, 114.0, 112.0, 115.0, 110.0, 119.0, 115.0, 116.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.1}, {"lowerIsBetter": true, "replicates": [135.0, 140.0, 140.0, 134.0, 135.0, 142.0, 137.0, 136.0, 131.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.7}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 67.0, 65.0, 68.0, 67.0, 63.0, 66.0, 65.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.5}], "name": "kraken", "value": 1493.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [170.94017094017093], "unit": "score", "name": "Richards", "value": 206.51669999999996}, {"lowerIsBetter": false, "replicates": [168.01075268817203], "unit": "score", "name": "DeltaBlue", "value": 393.53433600000017}, {"lowerIsBetter": false, "replicates": [278.70680044593087], "unit": "score", "name": "Encrypt", "value": 955.0574279999998}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [909.0909090909091], "unit": "score", "name": "RayTrace", "value": 813.9879}, {"lowerIsBetter": false, "replicates": [569.4760820045558], "unit": "score", "name": "Earley", "value": 1170.3090280000001}, {"lowerIsBetter": false, "replicates": [11076.923076923076], "unit": "score", "name": "Boyer", "value": 60.16679861111106}, {"lowerIsBetter": false, "replicates": [38980.769230769234], "unit": "score", "name": "RegExp", "value": 23.370113468179557}, {"lowerIsBetter": false, "replicates": [545.0108459869848], "unit": "score", "name": "Splay", "value": 149.5217950248757}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 21919.277378221916}]} 16:39:14 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "21919.28"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1493.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7423.12"}}} 16:39:14 INFO - Return code: 0 16:39:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 16:39:14 INFO - # TBPL SUCCESS # 16:39:14 INFO - Running post-action listener: _resource_record_post_action 16:39:14 INFO - Running post-run listener: _resource_record_post_run 16:39:15 INFO - Total resource usage - Wall time: 1312s; CPU: 14.0%; Read bytes: 868352; Write bytes: 532774912; Read time: 4336; Write time: 6581900 16:39:15 INFO - install - Wall time: 23s; CPU: 22.0%; Read bytes: 0; Write bytes: 112668672; Read time: 0; Write time: 1917300 16:39:15 INFO - run-tests - Wall time: 1290s; CPU: 13.0%; Read bytes: 868352; Write bytes: 418971648; Read time: 4336; Write time: 4659164 16:39:15 INFO - Running post-run listener: _upload_blobber_files 16:39:15 INFO - Blob upload gear active. 16:39:15 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 16:39:15 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 16:39:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 16:39:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 16:39:16 INFO - (blobuploader) - INFO - Open directory for files ... 16:39:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:39:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:39:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:39:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:39:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:39:18 INFO - (blobuploader) - INFO - Done attempting. 16:39:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:39:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:39:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:39:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:39:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:39:19 INFO - (blobuploader) - INFO - Done attempting. 16:39:19 INFO - (blobuploader) - INFO - Iteration through files over. 16:39:19 INFO - Return code: 0 16:39:19 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 16:39:19 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 16:39:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c42e9f902ccf197254c869f5defe76d76834413ee4b95f9d91b20ed4efcdf5fd02d3b2399dad1cf4e8acb0cd9052a2a2046452c54ee0c931e6f16ae6d7846acb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/50997c38fb1c2a0e207e7fcd3aa4469f9ec0d31702b443dac569dc5243c3633cb744eda3efab9f89f43dd0a014c04d8343f96482e369233113b32999174f6884"} 16:39:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 16:39:19 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 16:39:19 INFO - Contents: 16:39:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c42e9f902ccf197254c869f5defe76d76834413ee4b95f9d91b20ed4efcdf5fd02d3b2399dad1cf4e8acb0cd9052a2a2046452c54ee0c931e6f16ae6d7846acb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/50997c38fb1c2a0e207e7fcd3aa4469f9ec0d31702b443dac569dc5243c3633cb744eda3efab9f89f43dd0a014c04d8343f96482e369233113b32999174f6884"} 16:39:19 INFO - Running post-run listener: copy_logs_to_upload_dir 16:39:19 INFO - Copying logs to upload dir... 16:39:19 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 16:39:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1367.415979 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 47 secs) (at 2016-03-06 16:39:19.245566) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-06 16:39:19.249229) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1457302193.275829-704462114 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c42e9f902ccf197254c869f5defe76d76834413ee4b95f9d91b20ed4efcdf5fd02d3b2399dad1cf4e8acb0cd9052a2a2046452c54ee0c931e6f16ae6d7846acb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/50997c38fb1c2a0e207e7fcd3aa4469f9ec0d31702b443dac569dc5243c3633cb744eda3efab9f89f43dd0a014c04d8343f96482e369233113b32999174f6884"} build_url:https://queue.taskcluster.net/v1/task/T1cLqKpcRTCvibduD1IYww/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011583 build_url: 'https://queue.taskcluster.net/v1/task/T1cLqKpcRTCvibduD1IYww/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c42e9f902ccf197254c869f5defe76d76834413ee4b95f9d91b20ed4efcdf5fd02d3b2399dad1cf4e8acb0cd9052a2a2046452c54ee0c931e6f16ae6d7846acb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/50997c38fb1c2a0e207e7fcd3aa4469f9ec0d31702b443dac569dc5243c3633cb744eda3efab9f89f43dd0a014c04d8343f96482e369233113b32999174f6884"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-06 16:39:19.278714) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 16:39:19.279490) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1457302193.275829-704462114 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004634 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 16:39:19.361757) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-06 16:39:19.362174) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-06 16:39:19.362495) ========= ========= Total master_lag: 0.27 =========