builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-005 starttime: 1480956473.04 results: success (0) buildid: 20161205070638 builduid: ca6df37595034678b897c7b624369dfe revision: 46049b21980d67b13d6915c052a3025c273a1788 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-05 08:47:53.036710) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-05 08:47:53.037131) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-05 08:47:53.037473) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-05 08:47:53.069590) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 08:47:53.069923) ========= 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/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1480955414.221239-1221525279 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-05 08:47:53-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 113M=0s 2016-12-05 08:47:53 (113 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.145478 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 08:47:53.232392) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 08:47:53.232720) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1480955414.221239-1221525279 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013039 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 08:47:53.285709) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 08:47:53.286125) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 46049b21980d67b13d6915c052a3025c273a1788 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 46049b21980d67b13d6915c052a3025c273a1788 --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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1480955414.221239-1221525279 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-05 08:47:53,483 truncating revision to first 12 chars 2016-12-05 08:47:53,483 Setting DEBUG logging. 2016-12-05 08:47:53,483 attempt 1/10 2016-12-05 08:47:53,483 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/46049b21980d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-05 08:47:53,778 unpacking tar archive at: mozilla-aurora-46049b21980d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.598254 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 08:47:53.903309) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-05 08:47:53.903586) ========= script_repo_revision: 46049b21980d67b13d6915c052a3025c273a1788 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-05 08:47:53.903969) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-05 08:47:53.904232) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-05 08:47:53.930486) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-12-05 08:47:53.930757) ========= /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/. (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/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1480955414.221239-1221525279 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:47:54 INFO - MultiFileLogger online at 20161205 08:47:54 in /builds/slave/test 08:47:54 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 08:47:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:47:54 INFO - {'append_to_log': False, 08:47:54 INFO - 'base_work_dir': '/builds/slave/test', 08:47:54 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:47:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:47:54 INFO - 'branch': 'Mozilla-Aurora', 08:47:54 INFO - 'buildbot_json_path': 'buildprops.json', 08:47:54 INFO - 'config_files': ('talos/linux_config.py',), 08:47:54 INFO - 'default_actions': ('clobber', 08:47:54 INFO - 'read-buildbot-config', 08:47:54 INFO - 'download-and-extract', 08:47:54 INFO - 'populate-webroot', 08:47:54 INFO - 'create-virtualenv', 08:47:54 INFO - 'install', 08:47:54 INFO - 'run-tests'), 08:47:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:47:54 INFO - 'download_minidump_stackwalk': True, 08:47:54 INFO - 'download_symbols': 'ondemand', 08:47:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:47:54 INFO - 'tooltool.py': '/tools/tooltool.py', 08:47:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:47:54 INFO - '/tools/misc-python/virtualenv.py')}, 08:47:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:47:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:47:54 INFO - 'installer_path': 'installer.exe', 08:47:54 INFO - 'log_level': 'info', 08:47:54 INFO - 'log_name': 'talos', 08:47:54 INFO - 'log_to_console': True, 08:47:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:47:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:47:54 INFO - 'opt_config_files': (), 08:47:54 INFO - 'pip_index': False, 08:47:54 INFO - 'sps_profile': False, 08:47:54 INFO - 'sps_profile_interval': 0, 08:47:54 INFO - 'suite': 'dromaeojs-e10s', 08:47:54 INFO - 'system_bits': '32', 08:47:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:47:54 INFO - 'title': 'talos-linux64-ix-005', 08:47:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:47:54 INFO - 'use_talos_json': True, 08:47:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:47:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:47:54 INFO - 'work_dir': 'build'} 08:47:54 INFO - [mozharness: 2016-12-05 16:47:54.233659Z] Running clobber step. 08:47:54 INFO - Running pre-action listener: _resource_record_pre_action 08:47:54 INFO - Running main action method: clobber 08:47:54 INFO - rmtree: /builds/slave/test/build 08:47:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:47:54 INFO - Running post-action listener: _resource_record_post_action 08:47:54 INFO - [mozharness: 2016-12-05 16:47:54.690616Z] Finished clobber step (success) 08:47:54 INFO - [mozharness: 2016-12-05 16:47:54.690715Z] Running read-buildbot-config step. 08:47:54 INFO - Running pre-action listener: _resource_record_pre_action 08:47:54 INFO - Running main action method: read_buildbot_config 08:47:54 INFO - Using buildbot properties: 08:47:54 INFO - { 08:47:54 INFO - "project": "", 08:47:54 INFO - "product": "firefox", 08:47:54 INFO - "script_repo_revision": "production", 08:47:54 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 08:47:54 INFO - "repository": "", 08:47:54 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 08:47:54 INFO - "buildid": "20161205070638", 08:47:54 INFO - "pgo_build": "True", 08:47:54 INFO - "basedir": "/builds/slave/test", 08:47:54 INFO - "buildnumber": 697, 08:47:54 INFO - "slavename": "talos-linux64-ix-005", 08:47:54 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:47:54 INFO - "platform": "ubuntu64_hw", 08:47:54 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:47:54 INFO - "branch": "mozilla-aurora", 08:47:54 INFO - "repo_path": "releases/mozilla-aurora", 08:47:54 INFO - "revision": "46049b21980d67b13d6915c052a3025c273a1788", 08:47:54 INFO - "stage_platform": "linux64-pgo", 08:47:54 INFO - "builduid": "ca6df37595034678b897c7b624369dfe", 08:47:54 INFO - "slavebuilddir": "test" 08:47:54 INFO - } 08:47:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 08:47:54 INFO - Running post-action listener: _resource_record_post_action 08:47:54 INFO - [mozharness: 2016-12-05 16:47:54.693369Z] Finished read-buildbot-config step (success) 08:47:54 INFO - [mozharness: 2016-12-05 16:47:54.693456Z] Running download-and-extract step. 08:47:54 INFO - Running pre-action listener: _resource_record_pre_action 08:47:54 INFO - Running main action method: download_and_extract 08:47:54 INFO - mkdir: /builds/slave/test/build/tests 08:47: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:47:54 INFO - trying https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:47:54 INFO - Downloading https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:47:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:47:55 INFO - Downloaded 1361 bytes. 08:47:55 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:47:55 INFO - Using the following test package requirements: 08:47:55 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:47:55 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:47:55 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:47:55 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:47:55 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 08:47:55 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:47:55 INFO - u'jsshell-linux-x86_64.zip'], 08:47:55 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:47:55 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:47:55 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:47:55 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:47:55 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:47:55 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:47:55 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:47:55 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:47:55 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:47:55 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:47:55 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:47:55 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:47:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:47:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:47:55 INFO - Fetch https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:47:55 INFO - Http code: 200 08:47:55 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 08:47:55 INFO - x-amz-cf-id: Mq2cXhNtIIoWwWZIZjp-dEtQssqU27SBPIFxcxrAaRbD0iBeZ8ZfeQ== 08:47:55 INFO - x-amz-version-id: KqWZvKDpblLqtW1i2bA.CSkZ2ptCSO1S 08:47:56 INFO - Expected file size: 21954501 08:47:56 INFO - Obtained file size: 21954501 08:48:00 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:48:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:48:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:48:00 INFO - Fetch https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:48:01 INFO - Http code: 200 08:48:01 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 08:48:01 INFO - x-amz-cf-id: _-v3rJeDt-_E9RRP2pNiSYLGsDhoxBuxgMX3AsqfQMlSoMDjymDU_w== 08:48:01 INFO - x-amz-version-id: KqWZvKDpblLqtW1i2bA.CSkZ2ptCSO1S 08:48:01 INFO - Expected file size: 21954501 08:48:01 INFO - Obtained file size: 21954501 08:48:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 08:48:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:48:06 INFO - Fetch https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 08:48:06 INFO - Http code: 200 08:48:06 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 08:48:06 INFO - x-amz-cf-id: jN5so7n1LcvAntx263UpM3XiuAgov0x2mnv7WgUgxHx9lQzTD-QI5A== 08:48:06 INFO - x-amz-version-id: eAa_42RlakpvmLEJGtt93LWTNXz6JRCa 08:48:07 INFO - Expected file size: 14409038 08:48:07 INFO - Obtained file size: 14409038 08:48:08 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:08 INFO - trying https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:48:08 INFO - Downloading https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:48:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:48:10 INFO - Downloaded 63987567 bytes. 08:48:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:48:10 INFO - mkdir: /builds/slave/test/properties 08:48:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:48:10 INFO - Writing to file /builds/slave/test/properties/build_url 08:48:10 INFO - Contents: 08:48:10 INFO - build_url:https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:48:11 INFO - Running post-action listener: _resource_record_post_action 08:48:11 INFO - Running post-action listener: set_extra_try_arguments 08:48:11 INFO - [mozharness: 2016-12-05 16:48:11.204323Z] Finished download-and-extract step (success) 08:48:11 INFO - [mozharness: 2016-12-05 16:48:11.204555Z] Running populate-webroot step. 08:48:11 INFO - Running pre-action listener: _resource_record_pre_action 08:48:11 INFO - Running main action method: populate_webroot 08:48:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:48:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:48:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:48:11 INFO - '--tppagecycles', 08:48:11 INFO - '7'], 08:48:11 INFO - 'tests': ['tsvgm']}}, 08:48:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:48:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:48:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:48:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:48:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:48:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:48:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:11 INFO - 'talos_options': ['--disable-e10s'], 08:48:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:48:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:48:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:11 INFO - 'talos_options': ['--disable-e10s'], 08:48:11 INFO - 'tests': ['damp', 'tps']}, 08:48:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:11 INFO - 'tests': ['damp', 'tps']}, 08:48:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:48:11 INFO - 'tests': ['dromaeo_dom']}, 08:48:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:48:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:48:11 INFO - 'tests': ['basic_compositor_video']}, 08:48:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:48:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:48:11 INFO - 'tests': ['a11yr', 08:48:11 INFO - 'ts_paint', 08:48:11 INFO - 'tpaint', 08:48:11 INFO - 'sessionrestore', 08:48:11 INFO - 'sessionrestore_no_auto_restore', 08:48:11 INFO - 'tabpaint']}, 08:48:11 INFO - 'other-e10s': {'tests': ['a11yr', 08:48:11 INFO - 'ts_paint', 08:48:11 INFO - 'tpaint', 08:48:11 INFO - 'sessionrestore', 08:48:11 INFO - 'sessionrestore_no_auto_restore', 08:48:11 INFO - 'tabpaint']}, 08:48:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:48:11 INFO - 'ts_paint', 08:48:11 INFO - 'tpaint', 08:48:11 INFO - 'sessionrestore', 08:48:11 INFO - 'sessionrestore_no_auto_restore', 08:48:11 INFO - 'tabpaint']}, 08:48:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:48:11 INFO - 'ts_paint', 08:48:11 INFO - 'tpaint', 08:48:11 INFO - 'sessionrestore', 08:48:11 INFO - 'sessionrestore_no_auto_restore', 08:48:11 INFO - 'tabpaint']}, 08:48:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:48:11 INFO - 'tests': ['a11yr', 08:48:11 INFO - 'ts_paint', 08:48:11 INFO - 'tpaint', 08:48:11 INFO - 'sessionrestore', 08:48:11 INFO - 'sessionrestore_no_auto_restore', 08:48:11 INFO - 'tabpaint']}, 08:48:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:48:11 INFO - 'tests': ['a11yr', 08:48:11 INFO - 'ts_paint', 08:48:11 INFO - 'tpaint', 08:48:11 INFO - 'sessionrestore', 08:48:11 INFO - 'sessionrestore_no_auto_restore', 08:48:11 INFO - 'tabpaint']}, 08:48:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:48:11 INFO - 'tests': ['tsvgx', 08:48:11 INFO - 'tsvgr_opacity', 08:48:11 INFO - 'tart', 08:48:11 INFO - 'tscrollx', 08:48:11 INFO - 'cart']}, 08:48:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:48:11 INFO - 'tsvgr_opacity', 08:48:11 INFO - 'tart', 08:48:11 INFO - 'tscrollx', 08:48:11 INFO - 'cart']}, 08:48:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:11 INFO - 'talos_options': ['--disable-e10s'], 08:48:11 INFO - 'tests': ['tp5o']}, 08:48:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:11 INFO - 'tests': ['tp5o']}, 08:48:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:11 INFO - 'talos_options': ['--disable-e10s', 08:48:11 INFO - '--xperf_path', 08:48:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:48:11 INFO - 'tests': ['tp5n']}, 08:48:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:11 INFO - 'talos_options': ['--xperf_path', 08:48:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:48:11 INFO - 'tests': ['tp5n']}}, 08:48:11 INFO - 'talos.zip': {'path': '', 08:48:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:48:11 INFO - Running post-action listener: _resource_record_post_action 08:48:11 INFO - [mozharness: 2016-12-05 16:48:11.220251Z] Finished populate-webroot step (success) 08:48:11 INFO - [mozharness: 2016-12-05 16:48:11.220345Z] Running create-virtualenv step. 08:48:11 INFO - Running pre-action listener: _resource_record_pre_action 08:48:11 INFO - Running main action method: create_virtualenv 08:48:11 INFO - Creating virtualenv /builds/slave/test/build/venv 08:48:11 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:48:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:48:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:48:11 INFO - Using real prefix '/usr' 08:48:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:48:11 INFO - Installing distribute.............................................................................................................................................................................................done. 08:48:13 INFO - Installing pip.................done. 08:48:13 INFO - Return code: 0 08:48:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:48:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:48:13 INFO - Reading from file tmpfile_stdout 08:48:13 INFO - Output received: 08:48:13 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:48:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:48:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7f5a626d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x195cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1959f60>, '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 0x195ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x195b1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1480955414.221239-1221525279', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 08:48:13 INFO - Running command: ['/builds/slave/test/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/build 08:48:13 INFO - Copy/paste: /builds/slave/test/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 08:48:13 INFO - Using env: {'DISPLAY': ':0', 08:48:13 INFO - 'HOME': '/home/cltbld', 08:48:13 INFO - 'LANG': 'en_US.UTF-8', 08:48:14 INFO - 'LANGUAGE': 'en_US:en', 08:48:14 INFO - 'LOGNAME': 'cltbld', 08:48:14 INFO - 'MAIL': '/var/mail/cltbld', 08:48:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:14 INFO - 'MOZ_NO_REMOTE': '1', 08:48:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:14 INFO - 'NO_EM_RESTART': '1', 08:48:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:14 INFO - 'PWD': '/builds/slave/test', 08:48:14 INFO - 'SHELL': '/bin/bash', 08:48:14 INFO - 'SHLVL': '1', 08:48:14 INFO - 'TERM': 'linux', 08:48:14 INFO - 'TMOUT': '86400', 08:48:14 INFO - 'USER': 'cltbld', 08:48:14 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1480955414.221239-1221525279', 08:48:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:14 INFO - '_': '/tools/buildbot/bin/python'} 08:48:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:14 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 08:48:14 INFO - Cleaning up... 08:48:14 INFO - Return code: 0 08:48:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:48:14 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:14 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5a626d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x195cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1959f60>, '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 0x195ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x195b1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1480955414.221239-1221525279', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 08:48:14 INFO - Running command: ['/builds/slave/test/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>=3.1.1'] in /builds/slave/test/build 08:48:14 INFO - Copy/paste: /builds/slave/test/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>=3.1.1 08:48:14 INFO - Using env: {'DISPLAY': ':0', 08:48:14 INFO - 'HOME': '/home/cltbld', 08:48:14 INFO - 'LANG': 'en_US.UTF-8', 08:48:14 INFO - 'LANGUAGE': 'en_US:en', 08:48:14 INFO - 'LOGNAME': 'cltbld', 08:48:14 INFO - 'MAIL': '/var/mail/cltbld', 08:48:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:14 INFO - 'MOZ_NO_REMOTE': '1', 08:48:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:14 INFO - 'NO_EM_RESTART': '1', 08:48:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:14 INFO - 'PWD': '/builds/slave/test', 08:48:14 INFO - 'SHELL': '/bin/bash', 08:48:14 INFO - 'SHLVL': '1', 08:48:14 INFO - 'TERM': 'linux', 08:48:14 INFO - 'TMOUT': '86400', 08:48:14 INFO - 'USER': 'cltbld', 08:48:14 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1480955414.221239-1221525279', 08:48:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:14 INFO - '_': '/tools/buildbot/bin/python'} 08:48:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:14 INFO - Downloading/unpacking psutil>=3.1.1 08:48:14 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 08:48:14 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 08:48:14 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 08:48:14 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 08:48:14 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 08:48:14 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 08:48:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:48:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:48:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:48:16 INFO - Installing collected packages: psutil 08:48:16 INFO - Running setup.py install for psutil 08:48:16 INFO - building 'psutil._psutil_linux' extension 08:48:16 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 08:48:16 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 08:48:16 INFO - building 'psutil._psutil_posix' extension 08:48:16 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 08:48:16 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 08:48:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:48:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:48:17 INFO - Successfully installed psutil 08:48:17 INFO - Cleaning up... 08:48:17 INFO - Return code: 0 08:48:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:48:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5a626d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x195cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1959f60>, '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 0x195ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x195b1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1480955414.221239-1221525279', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 08:48:17 INFO - Running command: ['/builds/slave/test/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.3'] in /builds/slave/test/build 08:48:17 INFO - Copy/paste: /builds/slave/test/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.3 08:48:17 INFO - Using env: {'DISPLAY': ':0', 08:48:17 INFO - 'HOME': '/home/cltbld', 08:48:17 INFO - 'LANG': 'en_US.UTF-8', 08:48:17 INFO - 'LANGUAGE': 'en_US:en', 08:48:17 INFO - 'LOGNAME': 'cltbld', 08:48:17 INFO - 'MAIL': '/var/mail/cltbld', 08:48:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:17 INFO - 'MOZ_NO_REMOTE': '1', 08:48:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:17 INFO - 'NO_EM_RESTART': '1', 08:48:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:17 INFO - 'PWD': '/builds/slave/test', 08:48:17 INFO - 'SHELL': '/bin/bash', 08:48:17 INFO - 'SHLVL': '1', 08:48:17 INFO - 'TERM': 'linux', 08:48:17 INFO - 'TMOUT': '86400', 08:48:17 INFO - 'USER': 'cltbld', 08:48:17 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1480955414.221239-1221525279', 08:48:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:17 INFO - '_': '/tools/buildbot/bin/python'} 08:48:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:48:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:48:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:48:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:48:19 INFO - Installing collected packages: mozsystemmonitor 08:48:19 INFO - Running setup.py install for mozsystemmonitor 08:48:19 INFO - Successfully installed mozsystemmonitor 08:48:19 INFO - Cleaning up... 08:48:19 INFO - Return code: 0 08:48:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:48:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5a626d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x195cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1959f60>, '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 0x195ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x195b1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1480955414.221239-1221525279', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 08:48:19 INFO - Running command: ['/builds/slave/test/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==2.5.1'] in /builds/slave/test/build 08:48:19 INFO - Copy/paste: /builds/slave/test/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==2.5.1 08:48:19 INFO - Using env: {'DISPLAY': ':0', 08:48:19 INFO - 'HOME': '/home/cltbld', 08:48:19 INFO - 'LANG': 'en_US.UTF-8', 08:48:19 INFO - 'LANGUAGE': 'en_US:en', 08:48:19 INFO - 'LOGNAME': 'cltbld', 08:48:19 INFO - 'MAIL': '/var/mail/cltbld', 08:48:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:19 INFO - 'MOZ_NO_REMOTE': '1', 08:48:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:19 INFO - 'NO_EM_RESTART': '1', 08:48:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:19 INFO - 'PWD': '/builds/slave/test', 08:48:19 INFO - 'SHELL': '/bin/bash', 08:48:19 INFO - 'SHLVL': '1', 08:48:19 INFO - 'TERM': 'linux', 08:48:19 INFO - 'TMOUT': '86400', 08:48:19 INFO - 'USER': 'cltbld', 08:48:19 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1480955414.221239-1221525279', 08:48:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:19 INFO - '_': '/tools/buildbot/bin/python'} 08:48:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:19 INFO - Downloading/unpacking jsonschema==2.5.1 08:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:48:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:21 INFO - Downloading functools32-3.2.3-2.tar.gz 08:48:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:48:21 INFO - warning: no files found matching '*.txt' 08:48:21 INFO - no previously-included directories found matching 'build' 08:48:21 INFO - no previously-included directories found matching 'dist' 08:48:21 INFO - no previously-included directories found matching '.git*' 08:48:21 INFO - Installing collected packages: jsonschema, functools32 08:48:22 INFO - Running setup.py install for functools32 08:48:22 INFO - warning: no files found matching '*.txt' 08:48:22 INFO - no previously-included directories found matching 'build' 08:48:22 INFO - no previously-included directories found matching 'dist' 08:48:22 INFO - no previously-included directories found matching '.git*' 08:48:22 INFO - Successfully installed jsonschema functools32 08:48:22 INFO - Cleaning up... 08:48:22 INFO - Return code: 0 08:48:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5a626d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x195cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1959f60>, '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 0x195ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x195b1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1480955414.221239-1221525279', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 08:48:22 INFO - Running command: ['/builds/slave/test/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', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:48:22 INFO - Copy/paste: /builds/slave/test/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 functools32==3.2.3-2 08:48:22 INFO - Using env: {'DISPLAY': ':0', 08:48:22 INFO - 'HOME': '/home/cltbld', 08:48:22 INFO - 'LANG': 'en_US.UTF-8', 08:48:22 INFO - 'LANGUAGE': 'en_US:en', 08:48:22 INFO - 'LOGNAME': 'cltbld', 08:48:22 INFO - 'MAIL': '/var/mail/cltbld', 08:48:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:22 INFO - 'MOZ_NO_REMOTE': '1', 08:48:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:22 INFO - 'NO_EM_RESTART': '1', 08:48:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:22 INFO - 'PWD': '/builds/slave/test', 08:48:22 INFO - 'SHELL': '/bin/bash', 08:48:22 INFO - 'SHLVL': '1', 08:48:22 INFO - 'TERM': 'linux', 08:48:22 INFO - 'TMOUT': '86400', 08:48:22 INFO - 'USER': 'cltbld', 08:48:22 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1480955414.221239-1221525279', 08:48:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:22 INFO - '_': '/tools/buildbot/bin/python'} 08:48:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:48:22 INFO - Cleaning up... 08:48:22 INFO - Return code: 0 08:48:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7f5a626d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x195cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1959f60>, '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 0x195ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x195b1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1480955414.221239-1221525279', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 08:48:22 INFO - Running command: ['/builds/slave/test/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/build 08:48:22 INFO - Copy/paste: /builds/slave/test/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 08:48:22 INFO - Using env: {'DISPLAY': ':0', 08:48:22 INFO - 'HOME': '/home/cltbld', 08:48:22 INFO - 'LANG': 'en_US.UTF-8', 08:48:22 INFO - 'LANGUAGE': 'en_US:en', 08:48:22 INFO - 'LOGNAME': 'cltbld', 08:48:22 INFO - 'MAIL': '/var/mail/cltbld', 08:48:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:22 INFO - 'MOZ_NO_REMOTE': '1', 08:48:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:22 INFO - 'NO_EM_RESTART': '1', 08:48:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:22 INFO - 'PWD': '/builds/slave/test', 08:48:22 INFO - 'SHELL': '/bin/bash', 08:48:22 INFO - 'SHLVL': '1', 08:48:22 INFO - 'TERM': 'linux', 08:48:22 INFO - 'TMOUT': '86400', 08:48:22 INFO - 'USER': 'cltbld', 08:48:22 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1480955414.221239-1221525279', 08:48:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:22 INFO - '_': '/tools/buildbot/bin/python'} 08:48:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:22 INFO - Downloading/unpacking blobuploader==1.2.4 08:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:24 INFO - Downloading blobuploader-1.2.4.tar.gz 08:48:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:48:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:48:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:48:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:48:25 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 08:48:25 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 08:48:25 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 08:48:25 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 08:48:25 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 08:48:25 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 08:48:25 INFO - Downloading docopt-0.6.1.tar.gz 08:48:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:48:25 INFO - Installing collected packages: blobuploader, requests, docopt 08:48:25 INFO - Running setup.py install for blobuploader 08:48:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:48:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:48:25 INFO - Running setup.py install for requests 08:48:25 INFO - Running setup.py install for docopt 08:48:25 INFO - Successfully installed blobuploader requests docopt 08:48:25 INFO - Cleaning up... 08:48:26 INFO - Return code: 0 08:48:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/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 0x7f5a626d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x195cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1959f60>, '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 0x195ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x195b1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1480955414.221239-1221525279', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 08:48:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config 08:48:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/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 08:48:26 INFO - Using env: {'DISPLAY': ':0', 08:48:26 INFO - 'HOME': '/home/cltbld', 08:48:26 INFO - 'LANG': 'en_US.UTF-8', 08:48:26 INFO - 'LANGUAGE': 'en_US:en', 08:48:26 INFO - 'LOGNAME': 'cltbld', 08:48:26 INFO - 'MAIL': '/var/mail/cltbld', 08:48:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:26 INFO - 'MOZ_NO_REMOTE': '1', 08:48:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:26 INFO - 'NO_EM_RESTART': '1', 08:48:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:26 INFO - 'PWD': '/builds/slave/test', 08:48:26 INFO - 'SHELL': '/bin/bash', 08:48:26 INFO - 'SHLVL': '1', 08:48:26 INFO - 'TERM': 'linux', 08:48:26 INFO - 'TMOUT': '86400', 08:48:26 INFO - 'USER': 'cltbld', 08:48:26 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1480955414.221239-1221525279', 08:48:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:26 INFO - '_': '/tools/buildbot/bin/python'} 08:48:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:48:26 INFO - Running setup.py (path:/tmp/pip-8F6s06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:48:26 INFO - Running setup.py (path:/tmp/pip-2h84PK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:48:26 INFO - Running setup.py (path:/tmp/pip-K1Ghog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:48:26 INFO - Running setup.py (path:/tmp/pip-QGHMfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:48:26 INFO - Running setup.py (path:/tmp/pip-2VsrMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:48:26 INFO - Running setup.py (path:/tmp/pip-hG74f2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:48:26 INFO - Running setup.py (path:/tmp/pip-RZm4Gs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:48:26 INFO - Running setup.py (path:/tmp/pip-YFoEgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:48:26 INFO - Running setup.py (path:/tmp/pip-2xy4Jx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:48:26 INFO - Running setup.py (path:/tmp/pip-H0hwpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:48:26 INFO - Running setup.py (path:/tmp/pip-GHEDwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:48:27 INFO - Running setup.py (path:/tmp/pip-lD8Ft8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:48:27 INFO - Running setup.py (path:/tmp/pip-Fot7QM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:48:27 INFO - Running setup.py (path:/tmp/pip-RZS1Ue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:27 INFO - Running setup.py (path:/tmp/pip-aIz923-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:48:27 INFO - Running setup.py (path:/tmp/pip-22IUKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:48:27 INFO - Running setup.py (path:/tmp/pip-yJD4Mi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:48:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:48:27 INFO - Running setup.py install for manifestparser 08:48:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:48:27 INFO - Running setup.py install for mozcrash 08:48:27 INFO - Running setup.py install for mozdebug 08:48:27 INFO - Running setup.py install for mozdevice 08:48:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:48:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:48:27 INFO - Running setup.py install for mozfile 08:48:27 INFO - Running setup.py install for mozhttpd 08:48:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:48:28 INFO - Running setup.py install for mozinfo 08:48:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:48:28 INFO - Running setup.py install for mozInstall 08:48:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:48:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:48:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:48:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:48:28 INFO - Running setup.py install for mozleak 08:48:28 INFO - Running setup.py install for mozlog 08:48:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:48:28 INFO - Running setup.py install for moznetwork 08:48:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:48:28 INFO - Running setup.py install for mozprocess 08:48:28 INFO - Running setup.py install for mozprofile 08:48:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:48:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:48:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:48:28 INFO - Running setup.py install for mozrunner 08:48:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:48:28 INFO - Running setup.py install for mozscreenshot 08:48:29 INFO - Running setup.py install for moztest 08:48:29 INFO - Running setup.py install for mozversion 08:48:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:48:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:48:29 INFO - Cleaning up... 08:48:29 INFO - Return code: 0 08:48:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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 0x7f5a626d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x195cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1959f60>, '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 0x195ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x195b1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1480955414.221239-1221525279', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 08:48:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config 08:48:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/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 08:48:29 INFO - Using env: {'DISPLAY': ':0', 08:48:29 INFO - 'HOME': '/home/cltbld', 08:48:29 INFO - 'LANG': 'en_US.UTF-8', 08:48:29 INFO - 'LANGUAGE': 'en_US:en', 08:48:29 INFO - 'LOGNAME': 'cltbld', 08:48:29 INFO - 'MAIL': '/var/mail/cltbld', 08:48:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:29 INFO - 'MOZ_NO_REMOTE': '1', 08:48:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:29 INFO - 'NO_EM_RESTART': '1', 08:48:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:29 INFO - 'PWD': '/builds/slave/test', 08:48:29 INFO - 'SHELL': '/bin/bash', 08:48:29 INFO - 'SHLVL': '1', 08:48:29 INFO - 'TERM': 'linux', 08:48:29 INFO - 'TMOUT': '86400', 08:48:29 INFO - 'USER': 'cltbld', 08:48:29 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1480955414.221239-1221525279', 08:48:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:29 INFO - '_': '/tools/buildbot/bin/python'} 08:48:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:48:29 INFO - Running setup.py (path:/tmp/pip-f0_3qi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:48:29 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:48:29 INFO - Running setup.py (path:/tmp/pip-LUL4c0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:48:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:48:29 INFO - Running setup.py (path:/tmp/pip-4edx_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:48:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:48:29 INFO - Running setup.py (path:/tmp/pip-uLzUFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:48:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:48:29 INFO - Running setup.py (path:/tmp/pip-hALHNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:48:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:48:29 INFO - Running setup.py (path:/tmp/pip-zagEFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:48:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:48:29 INFO - Running setup.py (path:/tmp/pip-KT5wpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:48:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:48:29 INFO - Running setup.py (path:/tmp/pip-_xUT6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:48:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:48:30 INFO - Running setup.py (path:/tmp/pip-HLFRxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:48:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:48:30 INFO - Running setup.py (path:/tmp/pip-8hAGYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:48:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:48:30 INFO - Running setup.py (path:/tmp/pip-7XFXF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:48:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:48:30 INFO - Running setup.py (path:/tmp/pip-y3mcVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:48:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:48:30 INFO - Running setup.py (path:/tmp/pip-osvnlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:48:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:48:30 INFO - Running setup.py (path:/tmp/pip-WayCmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:48:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:30 INFO - Running setup.py (path:/tmp/pip-1OkdX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:48:30 INFO - Running setup.py (path:/tmp/pip-rH5jIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:48:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:48:30 INFO - Running setup.py (path:/tmp/pip-CoBcoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:48:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:48:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:48:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:48:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:48:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:48:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:48:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:32 INFO - Downloading blessings-1.6.tar.gz 08:48:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:48:32 INFO - Installing collected packages: blessings 08:48:32 INFO - Running setup.py install for blessings 08:48:32 INFO - Successfully installed blessings 08:48:32 INFO - Cleaning up... 08:48:32 INFO - Return code: 0 08:48:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:48:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:48:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:48:33 INFO - Reading from file tmpfile_stdout 08:48:33 INFO - Current package versions: 08:48:33 INFO - argparse == 1.2.1 08:48:33 INFO - blessings == 1.6 08:48:33 INFO - blobuploader == 1.2.4 08:48:33 INFO - docopt == 0.6.1 08:48:33 INFO - functools32 == 3.2.3-2 08:48:33 INFO - jsonschema == 2.5.1 08:48:33 INFO - manifestparser == 1.1 08:48:33 INFO - mozInstall == 1.12 08:48:33 INFO - mozcrash == 1.0 08:48:33 INFO - mozdebug == 0.1 08:48:33 INFO - mozdevice == 0.48 08:48:33 INFO - mozfile == 1.2 08:48:33 INFO - mozhttpd == 0.7 08:48:33 INFO - mozinfo == 0.9 08:48:33 INFO - mozleak == 0.1 08:48:33 INFO - mozlog == 3.4 08:48:33 INFO - moznetwork == 0.27 08:48:33 INFO - mozprocess == 0.23 08:48:33 INFO - mozprofile == 0.28 08:48:33 INFO - mozrunner == 6.13 08:48:33 INFO - mozscreenshot == 0.1 08:48:33 INFO - mozsystemmonitor == 0.3 08:48:33 INFO - moztest == 0.7 08:48:33 INFO - mozversion == 1.4 08:48:33 INFO - psutil == 3.1.1 08:48:33 INFO - requests == 1.2.3 08:48:33 INFO - wsgiref == 0.1.2 08:48:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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 0x7f5a626d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x195cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1959f60>, '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 0x195ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x195b1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1480955414.221239-1221525279', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 08:48:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/talos 08:48:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/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 08:48:33 INFO - Using env: {'DISPLAY': ':0', 08:48:33 INFO - 'HOME': '/home/cltbld', 08:48:33 INFO - 'LANG': 'en_US.UTF-8', 08:48:33 INFO - 'LANGUAGE': 'en_US:en', 08:48:33 INFO - 'LOGNAME': 'cltbld', 08:48:33 INFO - 'MAIL': '/var/mail/cltbld', 08:48:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:33 INFO - 'MOZ_NO_REMOTE': '1', 08:48:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:33 INFO - 'NO_EM_RESTART': '1', 08:48:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:33 INFO - 'PWD': '/builds/slave/test', 08:48:33 INFO - 'SHELL': '/bin/bash', 08:48:33 INFO - 'SHLVL': '1', 08:48:33 INFO - 'TERM': 'linux', 08:48:33 INFO - 'TMOUT': '86400', 08:48:33 INFO - 'USER': 'cltbld', 08:48:33 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1480955414.221239-1221525279', 08:48:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:33 INFO - '_': '/tools/buildbot/bin/python'} 08:48:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:48:33 INFO - Cleaning up... 08:48:33 INFO - Return code: 0 08:48:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:48: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7f5a626d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x195cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1959f60>, '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 0x195ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x195b1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1480955414.221239-1221525279', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 08:48:33 INFO - Running command: ['/builds/slave/test/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/build 08:48:33 INFO - Copy/paste: /builds/slave/test/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 08:48:33 INFO - Using env: {'DISPLAY': ':0', 08:48:33 INFO - 'HOME': '/home/cltbld', 08:48:33 INFO - 'LANG': 'en_US.UTF-8', 08:48:33 INFO - 'LANGUAGE': 'en_US:en', 08:48:33 INFO - 'LOGNAME': 'cltbld', 08:48:33 INFO - 'MAIL': '/var/mail/cltbld', 08:48:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:33 INFO - 'MOZ_NO_REMOTE': '1', 08:48:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:33 INFO - 'NO_EM_RESTART': '1', 08:48:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:33 INFO - 'PWD': '/builds/slave/test', 08:48:33 INFO - 'SHELL': '/bin/bash', 08:48:33 INFO - 'SHLVL': '1', 08:48:33 INFO - 'TERM': 'linux', 08:48:33 INFO - 'TMOUT': '86400', 08:48:33 INFO - 'USER': 'cltbld', 08:48:33 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1480955414.221239-1221525279', 08:48:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:33 INFO - '_': '/tools/buildbot/bin/python'} 08:48:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:48:33 INFO - Cleaning up... 08:48:33 INFO - Return code: 0 08:48:33 INFO - Running post-action listener: _resource_record_post_action 08:48:33 INFO - Running post-action listener: _start_resource_monitoring 08:48:33 INFO - Starting resource monitoring. 08:48:33 INFO - [mozharness: 2016-12-05 16:48:33.628218Z] Finished create-virtualenv step (success) 08:48:33 INFO - [mozharness: 2016-12-05 16:48:33.628788Z] Running install step. 08:48:33 INFO - Running pre-action listener: _resource_record_pre_action 08:48:33 INFO - Running main action method: install 08:48:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:48:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:48:33 INFO - Reading from file tmpfile_stdout 08:48:33 INFO - Detecting whether we're running mozinstall >=1.0... 08:48:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:48:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:48:33 INFO - Reading from file tmpfile_stdout 08:48:33 INFO - Output received: 08:48:33 INFO - Usage: mozinstall [options] installer 08:48:33 INFO - Options: 08:48:33 INFO - -h, --help show this help message and exit 08:48:33 INFO - -d DEST, --destination=DEST 08:48:33 INFO - Directory to install application into. [default: 08:48:33 INFO - "/builds/slave/test"] 08:48:33 INFO - --app=APP Application being installed. [default: firefox] 08:48:33 INFO - mkdir: /builds/slave/test/build/application 08:48:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:48:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:48:49 INFO - Reading from file tmpfile_stdout 08:48:49 INFO - Output received: 08:48:49 INFO - /builds/slave/test/build/application/firefox/firefox 08:48:49 INFO - Running post-action listener: _resource_record_post_action 08:48:49 INFO - [mozharness: 2016-12-05 16:48:49.969020Z] Finished install step (success) 08:48:49 INFO - [mozharness: 2016-12-05 16:48:49.969265Z] Running run-tests step. 08:48:49 INFO - Running pre-action listener: _resource_record_pre_action 08:48:49 INFO - Running main action method: run_tests 08:48:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:48:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:48:49 INFO - Python 2.7.3 08:48:49 INFO - Return code: 0 08:48:49 INFO - grabbing minidump binary from tooltool 08:48: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:49 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/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1959f60>, '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 0x195ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x195b1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:48:49 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:48:49 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:48:49 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:48:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:48:50 INFO - Return code: 0 08:48:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:48:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:48:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:48:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:48:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:48:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:48:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:48:50 INFO - Using env: {'DISPLAY': ':0', 08:48:50 INFO - 'HOME': '/home/cltbld', 08:48:50 INFO - 'LANG': 'en_US.UTF-8', 08:48:50 INFO - 'LANGUAGE': 'en_US:en', 08:48:50 INFO - 'LOGNAME': 'cltbld', 08:48:50 INFO - 'MAIL': '/var/mail/cltbld', 08:48:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:48:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:48:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:50 INFO - 'MOZ_NO_REMOTE': '1', 08:48:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:48:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:50 INFO - 'NO_EM_RESTART': '1', 08:48:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:50 INFO - 'PWD': '/builds/slave/test', 08:48:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:48:50 INFO - 'SHELL': '/bin/bash', 08:48:50 INFO - 'SHLVL': '1', 08:48:50 INFO - 'TERM': 'linux', 08:48:50 INFO - 'TMOUT': '86400', 08:48:50 INFO - 'USER': 'cltbld', 08:48:50 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1480955414.221239-1221525279', 08:48:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:50 INFO - '_': '/tools/buildbot/bin/python'} 08:48:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:48:50 INFO - mozversion application_buildid: 20161205070638 08:48:50 INFO - mozversion application_changeset: 46049b21980d67b13d6915c052a3025c273a1788 08:48:50 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:48:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:48:50 INFO - mozversion application_name: Firefox 08:48:50 INFO - mozversion application_remotingname: firefox-dev 08:48:50 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:48:50 INFO - mozversion application_vendor: Mozilla 08:48:50 INFO - mozversion application_version: 52.0a2 08:48:50 INFO - mozversion platform_buildid: 20161205070638 08:48:50 INFO - mozversion platform_changeset: 46049b21980d67b13d6915c052a3025c273a1788 08:48:50 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:48:50 INFO - mozversion platform_version: 52.0a2 08:48:50 INFO - using testdate: 1480956530 08:48:50 INFO - actual date: 1480956530 08:48:50 INFO - starting webserver on 'localhost:54387' 08:48:50 INFO - SUITE-START | Running 2 tests 08:48:50 INFO - TEST-START | dromaeo_css 08:48:50 INFO - operating with platform_type : linux_ 08:48:50 INFO - Initialising browser for dromaeo_css test... 08:48:50 INFO - TEST-INFO | started process 31146 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvu7m1p/profile http://localhost:54387/getInfo.html) 08:48:54 INFO - PROCESS | 31146 | __metrics Screen width/height:1600/1200 08:48:54 INFO - PROCESS | 31146 | colorDepth:24 08:48:54 INFO - PROCESS | 31146 | Browser inner width/height: 1024/697 08:48:54 INFO - PROCESS | 31146 | __metrics 08:48:55 ERROR - PROCESS | 31146 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 08:48:56 INFO - TEST-INFO | 31146: exit 0 08:48:56 INFO - Browser initialized. 08:48:56 INFO - Running cycle 1/1 for dromaeo_css test... 08:48:56 INFO - TEST-INFO | started process 31276 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvu7m1p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:49:07 INFO - PROCESS | 31276 | RSS: Main: 152309760 08:49:07 INFO - PROCESS | 31276 | 08:49:57 INFO - PROCESS | 31276 | 1480956597582 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] 08:52:08 INFO - PROCESS | 31276 | Cycle 1(1): loaded http://localhost:54387/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54387/tests/dromaeo/cssquery-ext.html) 08:52:09 INFO - PROCESS | 31276 | RSS: Main: 156504064 08:52:09 INFO - PROCESS | 31276 | 08:55:11 INFO - PROCESS | 31276 | Cycle 1(1): loaded http://localhost:54387/tests/dromaeo/cssquery-ext.html (next: http://localhost:54387/tests/dromaeo/cssquery-jquery.html) 08:55:12 INFO - PROCESS | 31276 | RSS: Main: 153538560 08:55:12 INFO - PROCESS | 31276 | 08:58:14 INFO - PROCESS | 31276 | Cycle 1(1): loaded http://localhost:54387/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54387/tests/dromaeo/cssquery-mootools.html) 08:58:14 INFO - PROCESS | 31276 | RSS: Main: 153767936 08:58:14 INFO - PROCESS | 31276 | 09:01:16 INFO - PROCESS | 31276 | Cycle 1(1): loaded http://localhost:54387/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54387/tests/dromaeo/cssquery-prototype.html) 09:01:17 INFO - PROCESS | 31276 | RSS: Main: 152309760 09:01:17 INFO - PROCESS | 31276 | 09:04:19 INFO - PROCESS | 31276 | Cycle 1(1): loaded http://localhost:54387/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54387/tests/dromaeo/cssquery-yui.html) 09:04:20 INFO - PROCESS | 31276 | RSS: Main: 154349568 09:04:20 INFO - PROCESS | 31276 | 09:07:22 INFO - PROCESS | 31276 | Cycle 1(1): loaded http://localhost:54387/tests/dromaeo/cssquery-yui.html (next: http://localhost:54387/tests/dromaeo/cssquery-dojo.html) 09:07:23 INFO - PROCESS | 31276 | RSS: Main: 155320320 09:07:23 INFO - PROCESS | 31276 | 09:07:23 INFO - PROCESS | 31276 | __start_tp_report 09:07:23 INFO - PROCESS | 31276 | _x_x_mozilla_page_load 09:07:23 INFO - PROCESS | 31276 | _x_x_mozilla_page_load_details 09:07:23 INFO - PROCESS | 31276 | |i|pagename|runs| 09:07:23 INFO - PROCESS | 31276 | |0;dojo.html;3225.741940644749;3234.1591186291566;3251.252211991242;3262.9184270393253;3281.3273278977813;5681.943180568198;5728.3126024876965;5733.283339582552;5745.971270143648;5773.22061521695;5644.181593668915;5672.404397538261;5673.801416950398;5694.943050569493;5706.514946229565;5151.330327057477;5189.247559103927;5191.740412979355;5229.86925326868;5230.2416149658275;5246.239295302179;5248.134057880445;5249.842504724865;5272.261883336336;5278.920816187741;5150.3047088642925;5163.225516172585;5236.423993360746;5237.947620523784;5289.18017707256;5140.614453915952;5173.586113110942;5205.609579281569;5216.817411390583;5265.842024739264;5200.323957885488;5215.035218484592;5222.738863056832;5225.346831646044;5308.309919710451;5724.513416359614;5771.105478650816;5799.2750906136735;5863.2670916135485;5875.706214689291;6072.180255665473;6092.603980741282;6122.938770612282;6124.6325220486915;6128.96935515324;6128.662923539204;6134.294556126058;6155.507559395238;6158.620278092748;6178.07328900664;5543.113101903757;5599.468050535193;5787.247657804501;5789.073748200268;5800.53595712342;6116.883633902656;6131.0708424985305;6142.846428839225;6225.62646241227;6282.560220784592;6119.084030306531;6124.601900876518;6126.9452004266695;6142.2839182294965;6149.692515374303;6123.571350005457;6182.876342473215;6194.287656919512;6211.720472578745;6217.658028808459;5990.6705131218205;6048.606840555438;6056.636601803906;6194.659293738888;6208.658523781235;6079.726412311456;6125.9680843641045;6131.927227014014;6132.08018797184;6140.657627863787;4725.9527404726205;4730.526947305242;4731.053789242165;4741.2176990796825;4763.928541071887;4082.1835632873544;4131.256373852735;4168.458100446983;4200.978995105005;4240.194363071007;5751.4536119068625;5762.193292938992;5826.883462330815;5833.445822646841;5880.647161170344;6050.334463209044;6078.240219972504;6109.816705498843;6113.419225173601;6113.510919126459;5819.73811178498;5833.212516310244;5845.561582881301;5895.174675545427;5904.114382842608;5247.0292995795135;5261.973690131525;5287.206918962186;5313.946860531422;5333.066713325153;6404.423601875854;6410.61536307823;6425.036244563353;6426.485881129592;6439.484841212692;6185.103160041679;6206.472449841814;6217.067439883873;6230;6232.158658581034;6128.442013631005;6230.158928544589;6265.874682506415;6288.968555157195;6359.3640635936035;6036.6679832609625;6046.425589568984;6052.152698622284;6062.696865156813;6107.816765497042;6135.6932153393045;6136.048912418582;6148.292946311231;6170.382961703794;6182.567220294536;5778.422157784188;5801.622894511843;6022.427869352405;6063.514918806397;6073.665948372882;5994.190784244246;6038.84902877414;6088.086786981811;6105.664188469676;6112.938870611237;5968.074948383008;5974.462298393166;5974.850628734316;5989.490893274121;5991.970040149771;5867.73595188209;5932.733027013708;6052.667103309184;6057.939860524302;6092.69536523181;5857.121431785266;5884.411558844081;5898.4101589840675;5957.434043765836;5959.702014899324 09:07:23 INFO - PROCESS | 31276 | |1;ext.html;576.7058800011993;615.7660089166117;648.7956293767463;665.8002599220233;677.0622687577703;44407.111857762866;45477.31784023243;45783.31325030123;49074.50925490744;49190;46901.765491172584;47318.0536389272;47347.0530589388;47351.52648473514;47456;8795.208431241186;8940.19538241558;8967.730968070968;8973.237274831647;8981.416207946462;8718.17177368149;8864.911350886474;8894.644214231455;8899.866502002475;8907.465552066897;8900.599473023729;8901.06538813425;8902.777430564223;8916.509591972439;8949.865752013693;8837.337199710015;8862.24670902974;8868.8669669955;8872.600732967032;8886.333524985619;8794.956025219833;8847.646094156291;8881.822363552692;8888.288936885034;8911.821763564692;43644.345334820006;44164.33753493668;44190;44207.115857682664;44309;3509.6139424663265;3641.089727568108;3744.2698673758628;4160.54234034256;4508.639308855284;33040.33919321624;33974.32051358984;33994.32011359784;34420;34797.47803782945;4488.371627972087;4510.0979804039325;4510.458744950627;4519.728816271035;4536.614387777043;255555;256092;353643;353982;357660;64376;64411.67794161093;64447.67776161183;64964;65058.67470662617;64884.35115648783;65120.67439662866;65255.347446524924;65668.67165664237;65696.34303656998;16496.67006659884;16530.917345413436;16531.173441328127;16650.75023874643;16704;14217.786733199011;14290.071145375518;14312.427502899976;14346.282685865874;14353.78469322961;17956.20013378429;18330;18589.907050464662;18761.34335298258;18808.81191188098;6369.108324834527;6403.935960640334;6419.005054216604;6492.740290388426;6599.967000165065;954.7708549947962;996.6760802739138;1023.1583150329526;1044.738815296176;1103.420704130338;31668.683313167036;32048.35903281921;32104;32637.184070397954;32780.672193277765;1097.3470784882982;1135.4209353229912;1155.0124643429915;1184.1474138620179;1196.3121205306984;16549.392078370824;16564.420245291356;16956.406525771537;16984.915075424542;17030.48908532746;481711;482958;483150;483534;486508;62117.378826212065;62146;62263.37736622666;62278.68860655758;62599.37400626027;1373.8626137386182;1378.152436251718;1381.0884816021578;1411.0686946615185;1425.8716715495655;30036.399272014;31566.84216578994;32090.35819283648;32154.67845321517;33219.169520762174;54174.45825541694;54614.18078728902;54671.72664136654;54696.45303546914;54750;349719;350118;350398;350859;351011;30456;30741.53887691731;31098;31104.533431998087;31105.222369440944;50294.49705502898;50918.490815091376;51915.96168076693;54072.45927540831;54336;42638.36042459428;44155.337669935616;44173.55826441823;44210.77894610506;45296.32055519236;41535;42693.35959960541;42895.356569652104;42965.78517107519;45010.54989450194;44156.779216105;44245.11509769851;44741.77629111834;45130.323045153695;45459.54540454553;38369.4244586337;39288;39638.405423918084;39756.60243397645;40018.19963600653;29800.254993625334;29815.403691926473;29939.401211976074;29976.70023299739;30131.548026780056 09:07:23 INFO - PROCESS | 31276 | |2;jquery.html;418.4100418410043;426.6501468795588;432.7425182016699;434.76522677754014;445.6523911349147;18321.72517412238;19115.235390584396;20077.09653065612;20157.294494692687;20587.897060514715;18781.812181878176;19604;19822.801771982275;19830.70253946192;20379.28672496463;5288.101022826119;5522.061249587579;5535.58483113766;5546.77812887486;5562.054450743363;5223.529882310591;5327.387350454689;5364.517193452589;5378.112611419111;5435.755391007414;5417.3770016448025;5436.592255580847;5438.592105592076;5442.047641662713;5457.5633949283965;5252.212168174785;5401.918971215435;5455.618106732531;5456.645318054314;5470.124780035176;5253.52718255355;5304.602154838402;5306.3632364116165;5310.867228319285;5318.547923426513;22319.665205021938;23195.884020579957;23289.883550582308;23377.766222337897;24582;2308.5729140108965;2352.1532248390567;2494.1893884487613;2533.8226324157317;2699.5140874642557;10290.279680422373;10451.11165550929;10680.572777088908;10961.342319460779;11005.559777608885;2016.7882372350984;2017.5561376497146;2019.7879222681702;2056.3008577083865;2084.6456102462616;78753.60623196905;80534.99999999942;81337.59331203366;85560;86942;11482.48328825205;11630.76738465226;11895.39412179362;11941.52233910634;11959.999999999825;17234;17241.91379043097;17264.827351726573;17320.826791732172;17321;7660.233976602407;8053.436259461781;8070.112287648354;8122.675092996214;8269.710560130367;7958.3235424989525;8024.879626805603;8122.5126492410645;8150.38872084596;8202.630881610341;5136.8202112925865;5241.947580524222;5248.265242866002;5260.526552610207;5358.115910874662;2136.8076873081495;2174.6737989301732;2191.3316438486413;2191.485001024758;2229.609818281794;861.7974775927652;1015.7816069545083;1084.8969347911936;1121.5513794482272;1131.6944425005368;18578.163982620816;19469.51326216856;19997.60004799896;20034.799652003585;20178.495537611383;1001.1190152665607;1020.3724709303725;1026.7535791410007;1031.83490641497;1044.1385856668128;10617.946910265553;11346.432678366049;11384.658460246206;11440.542378304941;11541.480633371519;479450;483964;493165;497049;497975;94078;95274.52362738142;95365;96397;97596;1025.7179275699243;1047.6123834181249;1059.157969414333;1104.2435931387026;1106.319613437746;17768.822311776716;18073;18306.359277425225;18383.264669413074;18500.982445965063;40808.79595602003;42535;42743.786281068395;44020.779896101594;44919;59757.10364344625;60537.69731151316;60917.39082609117;61046.694766525885;61532.384676154456;9014.053524380108;9096.720705602627;9175.77060573491;9197.816043678955;9216.354855160344;10352.948235258775;14069.437222510986;14091.718165636836;14245.287735613385;14604.415823366946;11678.532858685898;11968.820467692818;12120;12243.816342754688;12424.56514022005;11887.346195959306;11942.880571194524;11975.341356225492;12033.759324813629;12146.392680366123;12070.215435996632;12222.20555663879;12239.632811015685;12417.813732793835;12468.251904885736;7960.761177164694;8473.49159050459;8912.420692654956;9281.67514137002;9471.810563788824;11456.312621242752;12564.623061308175;12717.8092328617;12726.554570589984;12925.935370323088 09:07:23 INFO - PROCESS | 31276 | |3;mootools.html;1517.954461366159;1532.3028022249875;1702.5743564108973;1784.9473105928173;1828.2961059991908;7861.842763144748;8095.757127286176;8330;8822.161894620009;8882.200601945831;8376.664933402672;8636.956815215915;8655.221030107288;8864.64541418344;8879.067697891709;2461.581531139706;2491.9003239870385;2494.5135698538793;2503.0113105323385;2510.083819405922;2435.8173137014705;2505.912293069743;2512.5477414065463;2524.2427271818474;2526.6967963844363;2446.3150317911013;2469.1851688942606;2476.8142389320783;2498.525280196766;2503.674522312097;2394.7605239476175;2414.915477958272;2428.2715185444295;2445.5353482838204;2453.3130723397476;2443.4746529496065;2445.2786428003783;2460.692413448319;2463.938401539958;2464.9876750616313;8721.738347849574;8750.824983500357;8795.692150774692;8844.380893337404;8908;5404.270423492818;5466.945330546683;5542.5565954723525;5544.833654990357;5549.306336707911;3354.66453354665;3366.461366181399;3384.3738908302043;3440.8451619677176;3473.027552285364;1103.0734183285997;1121.6915348279288;1126.2622981946838;1141.7602303516271;2173.71741673583;11725.472353744102;12097.516099356015;12109;12165.391730413532;12166.51333946641;4611.2852507861335;4643.558861908114;4738.289256611467;4740.905181896343;4761.142994261067;9784.55969481375;9799.510024498746;9828.31201815866;9829.852552211723;9887.950560247153;5276.445973172838;5279.287296215039;5337.492938170868;5337.519623233928;5355.598330125256;4455.064436468313;4772;4975.10448119342;4993.1262029144755;5045.621578381636;3900.4539364488996;3910.452536644872;3954.387070004154;4021.4369988201674;4027.134166154291;1208.9516419343304;1215.0826126274783;1225.3689349984766;1227.4227617511456;1253.2918900821007;872.3239489395769;958.9616415343447;976.3848775271675;986.9309148359689;1006.9125344627785;5659.8019069333195;5941.7623295067715;6119.357467465852;6295.150154729145;6353.714082866282;937.7421209167397;956.1203692602822;957.7366224288377;974.5176137811828;978.848278516831;3914.451976723261;3978.124812541236;4060.7869958962833;4119.732217405859;4262.168877068942;10571.15430765537;10949.343039417661;11011.504482298316;11053.392063436428;11057.281276716987;10936.289141205796;10944.069754070833;10948.39783811882;11007.119430445546;11045.613403530999;7866.528008319405;8242.835143297101;8247.257746802816;8325.750227493185;8441.577921104043;5783.8554036149435;5964.850878728066;5973.581849270683;6173.351798061319;6185.474234690102;9879.259055570717;9912.454814984956;9959.950200249243;9967.850482242917;10078.647247346307;10039.447830369108;10054;10119.544620491948;10137.138343240907;10231.693049208536;8009.118996910452;8040.83918321642;8209.425340226127;8228.588570571566;8240.093589705008;8494.1081186477;8517.74446766598;8568.657253709782;8574.27118694893;8581;7460.813479663052;7527.736529221451;7574.128975167926;7575.810604734926;7599.810004749926;7373;7517.774466766005;7552.9244707552225;7564.352476633135;7635.274648908345;6697.497687673346;6845.212800528003;6992.650367481504;6994.055802466602;7003.6498175092065;5039;5056.84829455117;5166.328377310925;5233.267342571967;5238.5023422774775;5167.431582525995;5171.431142574389;5244;5271.920921186262;5379.596530260168 09:07:23 INFO - PROCESS | 31276 | |4;prototype.html;346.81272113058947;355.0537816718444;355.804307630803;361.4542041517309;363.62364952274385;5488.862778430541;5651.039323315031;5725.942740572593;5725.942740572598;5732.340780810208;5576.442355764431;5592.5805564582615;5622.718864056801;5660.792291006501;5666.036773748462;4429.247028005247;4457.509673935864;4467.798949047301;4476.529964353745;4479.708818926776;4301.720388174758;4363.367311739796;4406.272964960777;4431.894849946282;4475.261581838992;4344.261475549164;4353.912921741563;4356.869293921188;4357.956420435803;4380.496242932056;4399.252127138394;4403.405540252073;4417.271150260203;4425.291953287458;4456.46522417312;3707.703383729295;3928.4303775952612;3939.4484772131923;3941.1526521797664;3959;5495.0658388073725;5497.422770609069;5512.80705175317;5518.089515229983;5519.806806761784;5076.873078173038;5096.898062038776;5103.897922041539;5109.054824857376;5113.309703190059;5758.539316854642;5835.299764028344;5860.09168578871;5863.618864773776;5901.675407852566;4215.662746980234;4227.154569086195;4235.788210589458;4241.597048280409;4244.808983595745;6180.165677633552;6213.782517611907;6223.626582405025;6224.128621992924;6229.9129791519445;4184;4348;4381.759003254788;4433.7118087324225;4434.467863856294;4435.800388982503;4437.511873693891;4439.067795762926;4443.511213766483;4450.1989641864775;5026.497350265017;5030.547250747377;5040.168372218616;5059.620528460307;5091.109055915274;5745.195672605839;5797.391273916178;5850.168139868308;5878.7954517056105;5941.465268125889;1461.0211158523814;1461.3423959218394;1468.0824484697064;1473.8894582906325;1478.2091581004327;1008.7160904906416;1035.7928414317166;1037.3257382701304;1042.4058286776617;1054.3568423261804;5526.281583394213;5544.336698990287;5545.584081193927;5608.401605542401;5649.830505084854;5850.765969361178;5857.648541087548;5860.150278209721;5889.705514724246;5960.066356204884;5416.864578385493;5518.724063796874;5558.194061861008;5561.916571251353;5571.637843540238;3145.7102587938834;3157.36852629475;3165.572647692578;3168.8732450702173;3176.857041433141;5858.677772722541;6128.3565225651555;6151.538634602333;6218.471429928507;6224.657643829542;5978.3124940631515;5997.790077347272;6002.519798416116;6009.188759517497;6015.39846015395;6119.368671471221;6121.816345509642;6144.324124346318;6147.784827531015;6263.624182548971;5805.941940580709;5815.749613832877;5824.835242801418;5860.619059761102;5888.528917686489;5756.280464941882;5800.010986761027;5817.912731308949;5824.679642619697;5873.530117590668;5856.809152075443;6065.211522502046;6100.444386681545;6148.04893651041;6191.628502289877;4275.828966841416;4283.922297685683;4288.442502474658;4290.957090429056;4321.330193819963;5884.735186916513;5979.133025711334;5982.1325907744;6015.819525414245;6125.264968203844;6001;6012.338642749207;6021.367756385516;6044.486218671286;6050.9394906050375;5936.495397891227;5974;6005.249343832021;6007.729652165575;6013.518918486423;5645.520130788765;5896.729759042713;5922.437368449991;5923.6757167269;5923.970380148072;5984.222051133324;6011.527175841947;6030.758769649165;6045.75816967334;6144.4777193937225;5524.58565607573;5796.159556864315;5883.294004719461;5913.940860591339;5959.344472108151 09:07:23 INFO - PROCESS | 31276 | |5;yui.html;743.2530307041422;771.0015529888793;846.3060290561738;862.1938487514171;881.3874357321662;15180.468683596077;16003.599910002256;16019;16060.67878642428;16136.919315403422;14542.636434089152;14759.852401475982;14819.555413337617;14846.406143754237;14860.479883204063;844.1178967978462;851.3359579527978;860.6772460327377;862.7799911022712;865.0138841720412;859.5659192108008;863.6329559937002;865.1002956924791;865.2169786343338;865.7878819689184;884.1953822021961;891.692366133686;893.2496702769672;897.7979954510248;897.905719899411;886.0740526150156;887.6981826179098;892.0989800301677;892.4823602310644;893.1916615463016;653.598037207119;656.1568384625781;656.1994366872408;658.8451713847242;659.2484567592948;13248.933755331162;13264.734705305937;13279.601611951657;13280.402381892742;13286.800697989442;12752.80870786939;12849.100562960597;13012.763787440274;13215.074944753775;13216.73566528664;11075.889241107647;11086.61196858106;11122.55509779608;11126.833097503544;11148.275362101438;3749.5500539935383;3791.5071040764524;3851.229754049173;3860.8455661773496;3941.093548483836;63638;63789.681051594445;64339.67830160866;65067.99999999953;65980;9696.224302055818;9949.80100397988;9958.053984871425;10210.591576337012;10260.743481413025;19344.903275483815;19388.70916936247;19400.126994285292;19416.611667766847;19428.708569371473;7908.719448006125;8419.621117049624;8515.744527664056;8598.87101693475;8680.262177714838;4441.733495990251;4520.61574766142;4605.286180642006;4752.334673145762;4997.700137991732;3448.9827550862087;3657.579378371521;3665.596784353719;3678.3378991781738;3695.815209239527;672.3814091036259;673.2224280955504;682.4676752133344;683.6513378177066;686.584616307127;723.2947875821033;755.6221889055472;764.533634482965;793.2860425616991;799.0890384961149;9514.191293739972;9601.183899368492;9730.270229732798;9788.55951482185;10241.94879025615;677.11298199359;743.4981387563481;747.6261869065468;766.1266156581502;786.2059320086754;4806.951930480651;5003.149464591028;5020.196768517093;5042.117629414838;5055.317532133115;59037;60978.69510652418;93899.53050234706;96158.76313371368;97632;80008;80243.59878200572;80542.19457805347;81341.59329203435;82558.58720706358;70559.2944070563;71994.64002679953;73797.26202738011;75679.62160189274;76180.61909690527;9542.952285238529;9551.61793528279;9584.808303834025;9655;9989.850152247576;47575;48177.5182248173;48554.51445485641;48937.75531122321;50353.244701330244;53860.46139538711;54338.18492722692;61448.38551614427;66538.66730666316;68258;12425.75148497007;12469.189502682659;12571.685707857378;13064.477420903437;13072.607821765363;14033.859661403256;15005.924970375077;15216.163111029;15231.847681523486;15676.05943643385;14168.574942751733;14405.855941440452;14619.488317908823;14721.484748033767;14822.851771482146;13232.603021909357;13291.202527847974;13837.861621383658;13945.860541394863;14846.925765371105;12198.390080495763;13068.934655326662;13203.603891882874;14017.649558760704;14302.356393962089;10694.679159625224;10706.357618542912;10931.617393391192;11161.49773260189;11565.248258863483;11695.88304116948;11906.821397679216;12005.39973001329;12082.154249202471;12388.380580971096 09:07:23 INFO - PROCESS | 31276 | __end_tp_report 09:07:23 INFO - PROCESS | 31276 | __start_cc_report 09:07:23 INFO - PROCESS | 31276 | _x_x_mozilla_cycle_collect,306 09:07:23 INFO - PROCESS | 31276 | __end_cc_report 09:07:23 INFO - PROCESS | 31276 | __startTimestamp1480957643190__endTimestamp 09:07:23 INFO - PROCESS | 31276 | 09:07:23 INFO - PROCESS | 31276 | ------- Summary: start ------- 09:07:23 INFO - PROCESS | 31276 | Number of tests: 6 09:07:23 INFO - PROCESS | 31276 | 09:07:23 INFO - PROCESS | 31276 | [#0] dojo.html Cycles:165 Average:5703.91 Median:5957.43 stddev:655.25 (11.0%) stddev-sans-first:627.75 09:07:23 INFO - PROCESS | 31276 | Values: 3225.7 3234.2 3251.3 3262.9 3281.3 5681.9 5728.3 5733.3 5746.0 5773.2 5644.2 5672.4 5673.8 5694.9 5706.5 5151.3 5189.2 5191.7 5229.9 5230.2 5246.2 5248.1 5249.8 5272.3 5278.9 5150.3 5163.2 5236.4 5237.9 5289.2 5140.6 5173.6 5205.6 5216.8 5265.8 5200.3 5215.0 5222.7 5225.3 5308.3 5724.5 5771.1 5799.3 5863.3 5875.7 6072.2 6092.6 6122.9 6124.6 6129.0 6128.7 6134.3 6155.5 6158.6 6178.1 5543.1 5599.5 5787.2 5789.1 5800.5 6116.9 6131.1 6142.8 6225.6 6282.6 6119.1 6124.6 6126.9 6142.3 6149.7 6123.6 6182.9 6194.3 6211.7 6217.7 5990.7 6048.6 6056.6 6194.7 6208.7 6079.7 6126.0 6131.9 6132.1 6140.7 4726.0 4730.5 4731.1 4741.2 4763.9 4082.2 4131.3 4168.5 4201.0 4240.2 5751.5 5762.2 5826.9 5833.4 5880.6 6050.3 6078.2 6109.8 6113.4 6113.5 5819.7 5833.2 5845.6 5895.2 5904.1 5247.0 5262.0 5287.2 5313.9 5333.1 6404.4 6410.6 6425.0 6426.5 6439.5 6185.1 6206.5 6217.1 6230.0 6232.2 6128.4 6230.2 6265.9 6289.0 6359.4 6036.7 6046.4 6052.2 6062.7 6107.8 6135.7 6136.0 6148.3 6170.4 6182.6 5778.4 5801.6 6022.4 6063.5 6073.7 5994.2 6038.8 6088.1 6105.7 6112.9 5968.1 5974.5 5974.9 5989.5 5992.0 5867.7 5932.7 6052.7 6057.9 6092.7 5857.1 5884.4 5898.4 5957.4 5959.7 09:07:23 INFO - PROCESS | 31276 | 09:07:23 INFO - PROCESS | 31276 | [#1] ext.html Cycles:180 Average:56850.68 Median:44277.06 stddev:103099.88 (232.9%) stddev-sans-first:103302.53 09:07:23 INFO - PROCESS | 31276 | Values: 576.7 615.8 648.8 665.8 677.1 44407.1 45477.3 45783.3 49074.5 49190.0 46901.8 47318.1 47347.1 47351.5 47456.0 8795.2 8940.2 8967.7 8973.2 8981.4 8718.2 8864.9 8894.6 8899.9 8907.5 8900.6 8901.1 8902.8 8916.5 8949.9 8837.3 8862.2 8868.9 8872.6 8886.3 8795.0 8847.6 8881.8 8888.3 8911.8 43644.3 44164.3 44190.0 44207.1 44309.0 3509.6 3641.1 3744.3 4160.5 4508.6 33040.3 33974.3 33994.3 34420.0 34797.5 4488.4 4510.1 4510.5 4519.7 4536.6 255555.0 256092.0 353643.0 353982.0 357660.0 64376.0 64411.7 64447.7 64964.0 65058.7 64884.4 65120.7 65255.3 65668.7 65696.3 16496.7 16530.9 16531.2 16650.8 16704.0 14217.8 14290.1 14312.4 14346.3 14353.8 17956.2 18330.0 18589.9 18761.3 18808.8 6369.1 6403.9 6419.0 6492.7 6600.0 954.8 996.7 1023.2 1044.7 1103.4 31668.7 32048.4 32104.0 32637.2 32780.7 1097.3 1135.4 1155.0 1184.1 1196.3 16549.4 16564.4 16956.4 16984.9 17030.5 481711.0 482958.0 483150.0 483534.0 486508.0 62117.4 62146.0 62263.4 62278.7 62599.4 1373.9 1378.2 1381.1 1411.1 1425.9 30036.4 31566.8 32090.4 32154.7 33219.2 54174.5 54614.2 54671.7 54696.5 54750.0 349719.0 350118.0 350398.0 350859.0 351011.0 30456.0 30741.5 31098.0 31104.5 31105.2 50294.5 50918.5 51916.0 54072.5 54336.0 42638.4 44155.3 44173.6 44210.8 45296.3 41535.0 42693.4 42895.4 42965.8 45010.5 44156.8 44245.1 44741.8 45130.3 45459.5 38369.4 39288.0 39638.4 39756.6 40018.2 29800.3 29815.4 29939.4 29976.7 30131.5 09:07:23 INFO - PROCESS | 31276 | 09:07:23 INFO - PROCESS | 31276 | [#2] jquery.html Cycles:180 Average:29525.21 Median:12752.23 stddev:80953.68 (634.8%) stddev-sans-first:81151.28 09:07:23 INFO - PROCESS | 31276 | Values: 418.4 426.7 432.7 434.8 445.7 18321.7 19115.2 20077.1 20157.3 20587.9 18781.8 19604.0 19822.8 19830.7 20379.3 5288.1 5522.1 5535.6 5546.8 5562.1 5223.5 5327.4 5364.5 5378.1 5435.8 5417.4 5436.6 5438.6 5442.0 5457.6 5252.2 5401.9 5455.6 5456.6 5470.1 5253.5 5304.6 5306.4 5310.9 5318.5 22319.7 23195.9 23289.9 23377.8 24582.0 2308.6 2352.2 2494.2 2533.8 2699.5 10290.3 10451.1 10680.6 10961.3 11005.6 2016.8 2017.6 2019.8 2056.3 2084.6 78753.6 80535.0 81337.6 85560.0 86942.0 11482.5 11630.8 11895.4 11941.5 11960.0 17234.0 17241.9 17264.8 17320.8 17321.0 7660.2 8053.4 8070.1 8122.7 8269.7 7958.3 8024.9 8122.5 8150.4 8202.6 5136.8 5241.9 5248.3 5260.5 5358.1 2136.8 2174.7 2191.3 2191.5 2229.6 861.8 1015.8 1084.9 1121.6 1131.7 18578.2 19469.5 19997.6 20034.8 20178.5 1001.1 1020.4 1026.8 1031.8 1044.1 10617.9 11346.4 11384.7 11440.5 11541.5 479450.0 483964.0 493165.0 497049.0 497975.0 94078.0 95274.5 95365.0 96397.0 97596.0 1025.7 1047.6 1059.2 1104.2 1106.3 17768.8 18073.0 18306.4 18383.3 18501.0 40808.8 42535.0 42743.8 44020.8 44919.0 59757.1 60537.7 60917.4 61046.7 61532.4 9014.1 9096.7 9175.8 9197.8 9216.4 10352.9 14069.4 14091.7 14245.3 14604.4 11678.5 11968.8 12120.0 12243.8 12424.6 11887.3 11942.9 11975.3 12033.8 12146.4 12070.2 12222.2 12239.6 12417.8 12468.3 7960.8 8473.5 8912.4 9281.7 9471.8 11456.3 12564.6 12717.8 12726.6 12925.9 09:07:23 INFO - PROCESS | 31276 | 09:07:23 INFO - PROCESS | 31276 | [#3] mootools.html Cycles:180 Average:5817.72 Median:5169.43 stddev:3218.71 (62.3%) stddev-sans-first:3211.51 09:07:23 INFO - PROCESS | 31276 | Values: 1518.0 1532.3 1702.6 1784.9 1828.3 7861.8 8095.8 8330.0 8822.2 8882.2 8376.7 8637.0 8655.2 8864.6 8879.1 2461.6 2491.9 2494.5 2503.0 2510.1 2435.8 2505.9 2512.5 2524.2 2526.7 2446.3 2469.2 2476.8 2498.5 2503.7 2394.8 2414.9 2428.3 2445.5 2453.3 2443.5 2445.3 2460.7 2463.9 2465.0 8721.7 8750.8 8795.7 8844.4 8908.0 5404.3 5466.9 5542.6 5544.8 5549.3 3354.7 3366.5 3384.4 3440.8 3473.0 1103.1 1121.7 1126.3 1141.8 2173.7 11725.5 12097.5 12109.0 12165.4 12166.5 4611.3 4643.6 4738.3 4740.9 4761.1 9784.6 9799.5 9828.3 9829.9 9888.0 5276.4 5279.3 5337.5 5337.5 5355.6 4455.1 4772.0 4975.1 4993.1 5045.6 3900.5 3910.5 3954.4 4021.4 4027.1 1209.0 1215.1 1225.4 1227.4 1253.3 872.3 959.0 976.4 986.9 1006.9 5659.8 5941.8 6119.4 6295.2 6353.7 937.7 956.1 957.7 974.5 978.8 3914.5 3978.1 4060.8 4119.7 4262.2 10571.2 10949.3 11011.5 11053.4 11057.3 10936.3 10944.1 10948.4 11007.1 11045.6 7866.5 8242.8 8247.3 8325.8 8441.6 5783.9 5964.9 5973.6 6173.4 6185.5 9879.3 9912.5 9960.0 9967.9 10078.6 10039.4 10054.0 10119.5 10137.1 10231.7 8009.1 8040.8 8209.4 8228.6 8240.1 8494.1 8517.7 8568.7 8574.3 8581.0 7460.8 7527.7 7574.1 7575.8 7599.8 7373.0 7517.8 7552.9 7564.4 7635.3 6697.5 6845.2 6992.7 6994.1 7003.6 5039.0 5056.8 5166.3 5233.3 5238.5 5167.4 5171.4 5244.0 5271.9 5379.6 09:07:23 INFO - PROCESS | 31276 | 09:07:23 INFO - PROCESS | 31276 | [#4] prototype.html Cycles:180 Average:4956.79 Median:5584.51 stddev:1443.93 (25.9%) stddev-sans-first:1405.91 09:07:23 INFO - PROCESS | 31276 | Values: 346.8 355.1 355.8 361.5 363.6 5488.9 5651.0 5725.9 5725.9 5732.3 5576.4 5592.6 5622.7 5660.8 5666.0 4429.2 4457.5 4467.8 4476.5 4479.7 4301.7 4363.4 4406.3 4431.9 4475.3 4344.3 4353.9 4356.9 4358.0 4380.5 4399.3 4403.4 4417.3 4425.3 4456.5 3707.7 3928.4 3939.4 3941.2 3959.0 5495.1 5497.4 5512.8 5518.1 5519.8 5076.9 5096.9 5103.9 5109.1 5113.3 5758.5 5835.3 5860.1 5863.6 5901.7 4215.7 4227.2 4235.8 4241.6 4244.8 6180.2 6213.8 6223.6 6224.1 6229.9 4184.0 4348.0 4381.8 4433.7 4434.5 4435.8 4437.5 4439.1 4443.5 4450.2 5026.5 5030.5 5040.2 5059.6 5091.1 5745.2 5797.4 5850.2 5878.8 5941.5 1461.0 1461.3 1468.1 1473.9 1478.2 1008.7 1035.8 1037.3 1042.4 1054.4 5526.3 5544.3 5545.6 5608.4 5649.8 5850.8 5857.6 5860.2 5889.7 5960.1 5416.9 5518.7 5558.2 5561.9 5571.6 3145.7 3157.4 3165.6 3168.9 3176.9 5858.7 6128.4 6151.5 6218.5 6224.7 5978.3 5997.8 6002.5 6009.2 6015.4 6119.4 6121.8 6144.3 6147.8 6263.6 5805.9 5815.7 5824.8 5860.6 5888.5 5756.3 5800.0 5817.9 5824.7 5873.5 5856.8 6065.2 6100.4 6148.0 6191.6 4275.8 4283.9 4288.4 4291.0 4321.3 5884.7 5979.1 5982.1 6015.8 6125.3 6001.0 6012.3 6021.4 6044.5 6050.9 5936.5 5974.0 6005.2 6007.7 6013.5 5645.5 5896.7 5922.4 5923.7 5924.0 5984.2 6011.5 6030.8 6045.8 6144.5 5524.6 5796.2 5883.3 5913.9 5959.3 09:07:23 INFO - PROCESS | 31276 | 09:07:23 INFO - PROCESS | 31276 | [#5] yui.html Cycles:180 Average:18122.67 Median:27697.68 stddev:23868.49 (86.2%) stddev-sans-first:23899.77 09:07:23 INFO - PROCESS | 31276 | Values: 743.3 771.0 846.3 862.2 881.4 15180.5 16003.6 16019.0 16060.7 16136.9 14542.6 14759.9 14819.6 14846.4 14860.5 844.1 851.3 860.7 862.8 865.0 859.6 863.6 865.1 865.2 865.8 884.2 891.7 893.2 897.8 897.9 886.1 887.7 892.1 892.5 893.2 653.6 656.2 656.2 658.8 659.2 13248.9 13264.7 13279.6 13280.4 13286.8 12752.8 12849.1 13012.8 13215.1 13216.7 11075.9 11086.6 11122.6 11126.8 11148.3 3749.6 3791.5 3851.2 3860.8 3941.1 63638.0 63789.7 64339.7 65068.0 65980.0 9696.2 9949.8 9958.1 10210.6 10260.7 19344.9 19388.7 19400.1 19416.6 19428.7 7908.7 8419.6 8515.7 8598.9 8680.3 4441.7 4520.6 4605.3 4752.3 4997.7 3449.0 3657.6 3665.6 3678.3 3695.8 672.4 673.2 682.5 683.7 686.6 723.3 755.6 764.5 793.3 799.1 9514.2 9601.2 9730.3 9788.6 10241.9 677.1 743.5 747.6 766.1 786.2 4807.0 5003.1 5020.2 5042.1 5055.3 59037.0 60978.7 93899.5 96158.8 97632.0 80008.0 80243.6 80542.2 81341.6 82558.6 70559.3 71994.6 73797.3 75679.6 76180.6 9543.0 9551.6 9584.8 9655.0 9989.9 47575.0 48177.5 48554.5 48937.8 50353.2 53860.5 54338.2 61448.4 66538.7 68258.0 12425.8 12469.2 12571.7 13064.5 13072.6 14033.9 15005.9 15216.2 15231.8 15676.1 14168.6 14405.9 14619.5 14721.5 14822.9 13232.6 13291.2 13837.9 13945.9 14846.9 12198.4 13068.9 13203.6 14017.6 14302.4 10694.7 10706.4 10931.6 11161.5 11565.2 11695.9 11906.8 12005.4 12082.2 12388.4 09:07:23 INFO - PROCESS | 31276 | -------- Summary: end -------- 09:07:23 INFO - PROCESS | 31276 | 09:07:23 INFO - TEST-INFO | 31276: exit 0 09:07:24 INFO - TEST-OK | dromaeo_css | took 1113749ms 09:07:24 INFO - TEST-START | kraken 09:07:24 INFO - operating with platform_type : linux_ 09:07:24 INFO - Initialising browser for kraken test... 09:07:24 INFO - TEST-INFO | started process 31648 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQvomM3/profile http://localhost:54387/getInfo.html) 09:07:28 INFO - PROCESS | 31648 | __metrics Screen width/height:1600/1200 09:07:28 INFO - PROCESS | 31648 | colorDepth:24 09:07:28 INFO - PROCESS | 31648 | Browser inner width/height: 1024/697 09:07:28 INFO - PROCESS | 31648 | __metrics 09:07:28 ERROR - PROCESS | 31648 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 09:07:29 INFO - TEST-INFO | 31648: exit 0 09:07:29 INFO - Browser initialized. 09:07:29 INFO - Running cycle 1/1 for kraken test... 09:07:29 INFO - TEST-INFO | started process 31778 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQvomM3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:07:41 INFO - PROCESS | 31778 | RSS: Main: 152268800 09:07:41 INFO - PROCESS | 31778 | 09:07:44 INFO - PROCESS | 31778 | Cycle 1(1): loaded http://localhost:54387/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54387/tests/kraken/driver.html?testName=audio-beat-detection) 09:07:45 INFO - PROCESS | 31778 | RSS: Main: 157302784 09:07:45 INFO - PROCESS | 31778 | 09:07:47 INFO - PROCESS | 31778 | Cycle 1(1): loaded http://localhost:54387/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54387/tests/kraken/driver.html?testName=audio-dft) 09:07:48 INFO - PROCESS | 31778 | RSS: Main: 154689536 09:07:48 INFO - PROCESS | 31778 | 09:07:51 INFO - PROCESS | 31778 | Cycle 1(1): loaded http://localhost:54387/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54387/tests/kraken/driver.html?testName=audio-fft) 09:07:51 INFO - PROCESS | 31778 | RSS: Main: 155754496 09:07:51 INFO - PROCESS | 31778 | 09:07:54 INFO - PROCESS | 31778 | Cycle 1(1): loaded http://localhost:54387/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54387/tests/kraken/driver.html?testName=audio-oscillator) 09:07:54 INFO - PROCESS | 31778 | RSS: Main: 155410432 09:07:54 INFO - PROCESS | 31778 | 09:07:56 INFO - PROCESS | 31778 | Cycle 1(1): loaded http://localhost:54387/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54387/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:07:57 INFO - PROCESS | 31778 | RSS: Main: 155017216 09:07:57 INFO - PROCESS | 31778 | 09:08:00 INFO - PROCESS | 31778 | Cycle 1(1): loaded http://localhost:54387/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54387/tests/kraken/driver.html?testName=imaging-darkroom) 09:08:01 INFO - PROCESS | 31778 | RSS: Main: 158945280 09:08:01 INFO - PROCESS | 31778 | 09:08:04 INFO - PROCESS | 31778 | Cycle 1(1): loaded http://localhost:54387/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54387/tests/kraken/driver.html?testName=imaging-desaturate) 09:08:05 INFO - PROCESS | 31778 | RSS: Main: 158863360 09:08:05 INFO - PROCESS | 31778 | 09:08:07 INFO - PROCESS | 31778 | Cycle 1(1): loaded http://localhost:54387/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54387/tests/kraken/driver.html?testName=json-parse-financial) 09:08:08 INFO - PROCESS | 31778 | RSS: Main: 157351936 09:08:08 INFO - PROCESS | 31778 | 09:08:09 INFO - PROCESS | 31778 | Cycle 1(1): loaded http://localhost:54387/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54387/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:08:10 INFO - PROCESS | 31778 | RSS: Main: 157143040 09:08:10 INFO - PROCESS | 31778 | 09:08:12 INFO - PROCESS | 31778 | Cycle 1(1): loaded http://localhost:54387/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54387/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:08:12 INFO - PROCESS | 31778 | RSS: Main: 157380608 09:08:12 INFO - PROCESS | 31778 | 09:08:14 INFO - PROCESS | 31778 | Cycle 1(1): loaded http://localhost:54387/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54387/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:08:15 INFO - PROCESS | 31778 | RSS: Main: 157466624 09:08:15 INFO - PROCESS | 31778 | 09:08:18 INFO - PROCESS | 31778 | Cycle 1(1): loaded http://localhost:54387/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54387/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:08:18 INFO - PROCESS | 31778 | RSS: Main: 157564928 09:08:18 INFO - PROCESS | 31778 | 09:08:21 INFO - PROCESS | 31778 | Cycle 1(1): loaded http://localhost:54387/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54387/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:08:22 INFO - PROCESS | 31778 | RSS: Main: 157765632 09:08:22 INFO - PROCESS | 31778 | 09:08:23 INFO - PROCESS | 31778 | Cycle 1(1): loaded http://localhost:54387/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54387/tests/kraken/driver.html?testName=ai-astar) 09:08:24 INFO - PROCESS | 31778 | RSS: Main: 159662080 09:08:24 INFO - PROCESS | 31778 | 09:08:24 INFO - PROCESS | 31778 | __start_tp_report 09:08:24 INFO - PROCESS | 31778 | _x_x_mozilla_page_load 09:08:24 INFO - PROCESS | 31778 | _x_x_mozilla_page_load_details 09:08:24 INFO - PROCESS | 31778 | |i|pagename|runs| 09:08:24 INFO - PROCESS | 31778 | |0;ai-astar;102;112;112;111;110;110;111;110;112;110 09:08:24 INFO - PROCESS | 31778 | |1;audio-beat-detection;153;125;123;171;123;127;132;129;150;127 09:08:24 INFO - PROCESS | 31778 | |2;audio-dft;163;166;173;166;163;163;162;163;162;162 09:08:24 INFO - PROCESS | 31778 | |3;audio-fft;75;75;74;113;75;76;75;75;109;75 09:08:24 INFO - PROCESS | 31778 | |4;audio-oscillator;83;83;110;84;82;81;97;82;82;113 09:08:24 INFO - PROCESS | 31778 | |5;imaging-gaussian-blur;117;118;117;117;118;117;118;118;117;120 09:08:24 INFO - PROCESS | 31778 | |6;imaging-darkroom;147;147;150;147;146;147;147;147;147;148 09:08:24 INFO - PROCESS | 31778 | |7;imaging-desaturate;84;85;85;87;86;85;85;86;86;85 09:08:24 INFO - PROCESS | 31778 | |8;json-parse-financial;51;52;51;51;50;52;53;52;52;55 09:08:24 INFO - PROCESS | 31778 | |9;json-stringify-tinderbox;59;60;59;60;60;59;59;60;60;60 09:08:24 INFO - PROCESS | 31778 | |10;stanford-crypto-aes;84;79;76;76;84;84;77;76;76;83 09:08:24 INFO - PROCESS | 31778 | |11;stanford-crypto-ccm;129;130;130;140;128;139;146;132;169;135 09:08:24 INFO - PROCESS | 31778 | |12;stanford-crypto-pbkdf2;162;157;162;158;158;159;157;163;158;158 09:08:24 INFO - PROCESS | 31778 | |13;stanford-crypto-sha256-iterative;64;65;68;64;68;67;63;69;62;64 09:08:24 INFO - PROCESS | 31778 | __end_tp_report 09:08:24 INFO - PROCESS | 31778 | __start_cc_report 09:08:24 INFO - PROCESS | 31778 | _x_x_mozilla_cycle_collect,831 09:08:24 INFO - PROCESS | 31778 | __end_cc_report 09:08:24 INFO - PROCESS | 31778 | __startTimestamp1480957704141__endTimestamp 09:08:24 INFO - PROCESS | 31778 | 09:08:24 INFO - PROCESS | 31778 | ------- Summary: start ------- 09:08:24 INFO - PROCESS | 31778 | Number of tests: 14 09:08:24 INFO - PROCESS | 31778 | 09:08:24 INFO - PROCESS | 31778 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:2.94 (2.7%) stddev-sans-first:0.93 09:08:24 INFO - PROCESS | 31778 | Values: 102.0 112.0 112.0 111.0 110.0 110.0 111.0 110.0 112.0 110.0 09:08:24 INFO - PROCESS | 31778 | 09:08:24 INFO - PROCESS | 31778 | [#1] audio-beat-detection Cycles:10 Average:136.00 Median:130.50 stddev:16.32 (12.5%) stddev-sans-first:16.10 09:08:24 INFO - PROCESS | 31778 | Values: 153.0 125.0 123.0 171.0 123.0 127.0 132.0 129.0 150.0 127.0 09:08:24 INFO - PROCESS | 31778 | 09:08:24 INFO - PROCESS | 31778 | [#2] audio-dft Cycles:10 Average:164.30 Median:163.00 stddev:3.40 (2.1%) stddev-sans-first:3.57 09:08:24 INFO - PROCESS | 31778 | Values: 163.0 166.0 173.0 166.0 163.0 163.0 162.0 163.0 162.0 162.0 09:08:24 INFO - PROCESS | 31778 | 09:08:24 INFO - PROCESS | 31778 | [#3] audio-fft Cycles:10 Average:82.20 Median:75.00 stddev:15.22 (20.3%) stddev-sans-first:15.91 09:08:24 INFO - PROCESS | 31778 | Values: 75.0 75.0 74.0 113.0 75.0 76.0 75.0 75.0 109.0 75.0 09:08:24 INFO - PROCESS | 31778 | 09:08:24 INFO - PROCESS | 31778 | [#4] audio-oscillator Cycles:10 Average:89.70 Median:82.50 stddev:12.40 (15.0%) stddev-sans-first:12.91 09:08:24 INFO - PROCESS | 31778 | Values: 83.0 83.0 110.0 84.0 82.0 81.0 97.0 82.0 82.0 113.0 09:08:24 INFO - PROCESS | 31778 | 09:08:24 INFO - PROCESS | 31778 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.95 (0.8%) stddev-sans-first:0.97 09:08:24 INFO - PROCESS | 31778 | Values: 117.0 118.0 117.0 117.0 118.0 117.0 118.0 118.0 117.0 120.0 09:08:24 INFO - PROCESS | 31778 | 09:08:24 INFO - PROCESS | 31778 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 09:08:24 INFO - PROCESS | 31778 | Values: 147.0 147.0 150.0 147.0 146.0 147.0 147.0 147.0 147.0 148.0 09:08:24 INFO - PROCESS | 31778 | 09:08:24 INFO - PROCESS | 31778 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:85.50 stddev:0.84 (1.0%) stddev-sans-first:0.73 09:08:24 INFO - PROCESS | 31778 | Values: 84.0 85.0 85.0 87.0 86.0 85.0 85.0 86.0 86.0 85.0 09:08:24 INFO - PROCESS | 31778 | 09:08:24 INFO - PROCESS | 31778 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:52.00 stddev:1.37 (2.6%) stddev-sans-first:1.41 09:08:24 INFO - PROCESS | 31778 | Values: 51.0 52.0 51.0 51.0 50.0 52.0 53.0 52.0 52.0 55.0 09:08:24 INFO - PROCESS | 31778 | 09:08:24 INFO - PROCESS | 31778 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:60.00 stddev:0.52 (0.9%) stddev-sans-first:0.50 09:08:24 INFO - PROCESS | 31778 | Values: 59.0 60.0 59.0 60.0 60.0 59.0 59.0 60.0 60.0 60.0 09:08:24 INFO - PROCESS | 31778 | 09:08:24 INFO - PROCESS | 31778 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:81.00 stddev:3.78 (4.7%) stddev-sans-first:3.64 09:08:24 INFO - PROCESS | 31778 | Values: 84.0 79.0 76.0 76.0 84.0 84.0 77.0 76.0 76.0 83.0 09:08:24 INFO - PROCESS | 31778 | 09:08:24 INFO - PROCESS | 31778 | [#11] stanford-crypto-ccm Cycles:10 Average:137.80 Median:137.00 stddev:12.40 (9.1%) stddev-sans-first:12.74 09:08:24 INFO - PROCESS | 31778 | Values: 129.0 130.0 130.0 140.0 128.0 139.0 146.0 132.0 169.0 135.0 09:08:24 INFO - PROCESS | 31778 | 09:08:24 INFO - PROCESS | 31778 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.20 Median:158.50 stddev:2.25 (1.4%) stddev-sans-first:2.15 09:08:24 INFO - PROCESS | 31778 | Values: 162.0 157.0 162.0 158.0 158.0 159.0 157.0 163.0 158.0 158.0 09:08:24 INFO - PROCESS | 31778 | 09:08:24 INFO - PROCESS | 31778 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:66.00 stddev:2.41 (3.7%) stddev-sans-first:2.51 09:08:24 INFO - PROCESS | 31778 | Values: 64.0 65.0 68.0 64.0 68.0 67.0 63.0 69.0 62.0 64.0 09:08:24 INFO - PROCESS | 31778 | -------- Summary: end -------- 09:08:24 INFO - PROCESS | 31778 | 09:08:25 INFO - TEST-INFO | 31778: exit 0 09:08:25 INFO - TEST-OK | kraken | took 61137ms 09:08:25 INFO - SUITE-END | took 1174s 09:08:25 INFO - Completed test suite (00:19:35) 09:08:25 INFO - javascript benchmark 09:08:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7469.441703949113, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3225.741940644749, 3234.1591186291566, 3251.252211991242, 3262.9184270393253, 3281.3273278977813, 5681.943180568198, 5728.3126024876965, 5733.283339582552, 5745.971270143648, 5773.22061521695, 5644.181593668915, 5672.404397538261, 5673.801416950398, 5694.943050569493, 5706.514946229565, 5151.330327057477, 5189.247559103927, 5191.740412979355, 5229.86925326868, 5230.2416149658275, 5246.239295302179, 5248.134057880445, 5249.842504724865, 5272.261883336336, 5278.920816187741, 5150.3047088642925, 5163.225516172585, 5236.423993360746, 5237.947620523784, 5289.18017707256, 5140.614453915952, 5173.586113110942, 5205.609579281569, 5216.817411390583, 5265.842024739264, 5200.323957885488, 5215.035218484592, 5222.738863056832, 5225.346831646044, 5308.309919710451, 5724.513416359614, 5771.105478650816, 5799.2750906136735, 5863.2670916135485, 5875.706214689291, 6072.180255665473, 6092.603980741282, 6122.938770612282, 6124.6325220486915, 6128.96935515324, 6128.662923539204, 6134.294556126058, 6155.507559395238, 6158.620278092748, 6178.07328900664, 5543.113101903757, 5599.468050535193, 5787.247657804501, 5789.073748200268, 5800.53595712342, 6116.883633902656, 6131.0708424985305, 6142.846428839225, 6225.62646241227, 6282.560220784592, 6119.084030306531, 6124.601900876518, 6126.9452004266695, 6142.2839182294965, 6149.692515374303, 6123.571350005457, 6182.876342473215, 6194.287656919512, 6211.720472578745, 6217.658028808459, 5990.6705131218205, 6048.606840555438, 6056.636601803906, 6194.659293738888, 6208.658523781235, 6079.726412311456, 6125.9680843641045, 6131.927227014014, 6132.08018797184, 6140.657627863787, 4725.9527404726205, 4730.526947305242, 4731.053789242165, 4741.2176990796825, 4763.928541071887, 4082.1835632873544, 4131.256373852735, 4168.458100446983, 4200.978995105005, 4240.194363071007, 5751.4536119068625, 5762.193292938992, 5826.883462330815, 5833.445822646841, 5880.647161170344, 6050.334463209044, 6078.240219972504, 6109.816705498843, 6113.419225173601, 6113.510919126459, 5819.73811178498, 5833.212516310244, 5845.561582881301, 5895.174675545427, 5904.114382842608, 5247.0292995795135, 5261.973690131525, 5287.206918962186, 5313.946860531422, 5333.066713325153, 6404.423601875854, 6410.61536307823, 6425.036244563353, 6426.485881129592, 6439.484841212692, 6185.103160041679, 6206.472449841814, 6217.067439883873, 6230.0, 6232.158658581034, 6128.442013631005, 6230.158928544589, 6265.874682506415, 6288.968555157195, 6359.3640635936035, 6036.6679832609625, 6046.425589568984, 6052.152698622284, 6062.696865156813, 6107.816765497042, 6135.6932153393045, 6136.048912418582, 6148.292946311231, 6170.382961703794, 6182.567220294536, 5778.422157784188, 5801.622894511843, 6022.427869352405, 6063.514918806397, 6073.665948372882, 5994.190784244246, 6038.84902877414, 6088.086786981811, 6105.664188469676, 6112.938870611237, 5968.074948383008, 5974.462298393166, 5974.850628734316, 5989.490893274121, 5991.970040149771, 5867.73595188209, 5932.733027013708, 6052.667103309184, 6057.939860524302, 6092.69536523181, 5857.121431785266, 5884.411558844081, 5898.4101589840675, 5957.434043765836, 5959.702014899324], "value": 5658.550265146926, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.7058800011993, 615.7660089166117, 648.7956293767463, 665.8002599220233, 677.0622687577703, 44407.111857762866, 45477.31784023243, 45783.31325030123, 49074.50925490744, 49190.0, 46901.765491172584, 47318.0536389272, 47347.0530589388, 47351.52648473514, 47456.0, 8795.208431241186, 8940.19538241558, 8967.730968070968, 8973.237274831647, 8981.416207946462, 8718.17177368149, 8864.911350886474, 8894.644214231455, 8899.866502002475, 8907.465552066897, 8900.599473023729, 8901.06538813425, 8902.777430564223, 8916.509591972439, 8949.865752013693, 8837.337199710015, 8862.24670902974, 8868.8669669955, 8872.600732967032, 8886.333524985619, 8794.956025219833, 8847.646094156291, 8881.822363552692, 8888.288936885034, 8911.821763564692, 43644.345334820006, 44164.33753493668, 44190.0, 44207.115857682664, 44309.0, 3509.6139424663265, 3641.089727568108, 3744.2698673758628, 4160.54234034256, 4508.639308855284, 33040.33919321624, 33974.32051358984, 33994.32011359784, 34420.0, 34797.47803782945, 4488.371627972087, 4510.0979804039325, 4510.458744950627, 4519.728816271035, 4536.614387777043, 255555.0, 256092.0, 353643.0, 353982.0, 357660.0, 64376.0, 64411.67794161093, 64447.67776161183, 64964.0, 65058.67470662617, 64884.35115648783, 65120.67439662866, 65255.347446524924, 65668.67165664237, 65696.34303656998, 16496.67006659884, 16530.917345413436, 16531.173441328127, 16650.75023874643, 16704.0, 14217.786733199011, 14290.071145375518, 14312.427502899976, 14346.282685865874, 14353.78469322961, 17956.20013378429, 18330.0, 18589.907050464662, 18761.34335298258, 18808.81191188098, 6369.108324834527, 6403.935960640334, 6419.005054216604, 6492.740290388426, 6599.967000165065, 954.7708549947962, 996.6760802739138, 1023.1583150329526, 1044.738815296176, 1103.420704130338, 31668.683313167036, 32048.35903281921, 32104.0, 32637.184070397954, 32780.672193277765, 1097.3470784882982, 1135.4209353229912, 1155.0124643429915, 1184.1474138620179, 1196.3121205306984, 16549.392078370824, 16564.420245291356, 16956.406525771537, 16984.915075424542, 17030.48908532746, 481711.0, 482958.0, 483150.0, 483534.0, 486508.0, 62117.378826212065, 62146.0, 62263.37736622666, 62278.68860655758, 62599.37400626027, 1373.8626137386182, 1378.152436251718, 1381.0884816021578, 1411.0686946615185, 1425.8716715495655, 30036.399272014, 31566.84216578994, 32090.35819283648, 32154.67845321517, 33219.169520762174, 54174.45825541694, 54614.18078728902, 54671.72664136654, 54696.45303546914, 54750.0, 349719.0, 350118.0, 350398.0, 350859.0, 351011.0, 30456.0, 30741.53887691731, 31098.0, 31104.533431998087, 31105.222369440944, 50294.49705502898, 50918.490815091376, 51915.96168076693, 54072.45927540831, 54336.0, 42638.36042459428, 44155.337669935616, 44173.55826441823, 44210.77894610506, 45296.32055519236, 41535.0, 42693.35959960541, 42895.356569652104, 42965.78517107519, 45010.54989450194, 44156.779216105, 44245.11509769851, 44741.77629111834, 45130.323045153695, 45459.54540454553, 38369.4244586337, 39288.0, 39638.405423918084, 39756.60243397645, 40018.19963600653, 29800.254993625334, 29815.403691926473, 29939.401211976074, 29976.70023299739, 30131.548026780056], "value": 20624.32589674028, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.4100418410043, 426.6501468795588, 432.7425182016699, 434.76522677754014, 445.6523911349147, 18321.72517412238, 19115.235390584396, 20077.09653065612, 20157.294494692687, 20587.897060514715, 18781.812181878176, 19604.0, 19822.801771982275, 19830.70253946192, 20379.28672496463, 5288.101022826119, 5522.061249587579, 5535.58483113766, 5546.77812887486, 5562.054450743363, 5223.529882310591, 5327.387350454689, 5364.517193452589, 5378.112611419111, 5435.755391007414, 5417.3770016448025, 5436.592255580847, 5438.592105592076, 5442.047641662713, 5457.5633949283965, 5252.212168174785, 5401.918971215435, 5455.618106732531, 5456.645318054314, 5470.124780035176, 5253.52718255355, 5304.602154838402, 5306.3632364116165, 5310.867228319285, 5318.547923426513, 22319.665205021938, 23195.884020579957, 23289.883550582308, 23377.766222337897, 24582.0, 2308.5729140108965, 2352.1532248390567, 2494.1893884487613, 2533.8226324157317, 2699.5140874642557, 10290.279680422373, 10451.11165550929, 10680.572777088908, 10961.342319460779, 11005.559777608885, 2016.7882372350984, 2017.5561376497146, 2019.7879222681702, 2056.3008577083865, 2084.6456102462616, 78753.60623196905, 80534.99999999942, 81337.59331203366, 85560.0, 86942.0, 11482.48328825205, 11630.76738465226, 11895.39412179362, 11941.52233910634, 11959.999999999825, 17234.0, 17241.91379043097, 17264.827351726573, 17320.826791732172, 17321.0, 7660.233976602407, 8053.436259461781, 8070.112287648354, 8122.675092996214, 8269.710560130367, 7958.3235424989525, 8024.879626805603, 8122.5126492410645, 8150.38872084596, 8202.630881610341, 5136.8202112925865, 5241.947580524222, 5248.265242866002, 5260.526552610207, 5358.115910874662, 2136.8076873081495, 2174.6737989301732, 2191.3316438486413, 2191.485001024758, 2229.609818281794, 861.7974775927652, 1015.7816069545083, 1084.8969347911936, 1121.5513794482272, 1131.6944425005368, 18578.163982620816, 19469.51326216856, 19997.60004799896, 20034.799652003585, 20178.495537611383, 1001.1190152665607, 1020.3724709303725, 1026.7535791410007, 1031.83490641497, 1044.1385856668128, 10617.946910265553, 11346.432678366049, 11384.658460246206, 11440.542378304941, 11541.480633371519, 479450.0, 483964.0, 493165.0, 497049.0, 497975.0, 94078.0, 95274.52362738142, 95365.0, 96397.0, 97596.0, 1025.7179275699243, 1047.6123834181249, 1059.157969414333, 1104.2435931387026, 1106.319613437746, 17768.822311776716, 18073.0, 18306.359277425225, 18383.264669413074, 18500.982445965063, 40808.79595602003, 42535.0, 42743.786281068395, 44020.779896101594, 44919.0, 59757.10364344625, 60537.69731151316, 60917.39082609117, 61046.694766525885, 61532.384676154456, 9014.053524380108, 9096.720705602627, 9175.77060573491, 9197.816043678955, 9216.354855160344, 10352.948235258775, 14069.437222510986, 14091.718165636836, 14245.287735613385, 14604.415823366946, 11678.532858685898, 11968.820467692818, 12120.0, 12243.816342754688, 12424.56514022005, 11887.346195959306, 11942.880571194524, 11975.341356225492, 12033.759324813629, 12146.392680366123, 12070.215435996632, 12222.20555663879, 12239.632811015685, 12417.813732793835, 12468.251904885736, 7960.761177164694, 8473.49159050459, 8912.420692654956, 9281.67514137002, 9471.810563788824, 11456.312621242752, 12564.623061308175, 12717.8092328617, 12726.554570589984, 12925.935370323088], "value": 9512.481607496975, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1517.954461366159, 1532.3028022249875, 1702.5743564108973, 1784.9473105928173, 1828.2961059991908, 7861.842763144748, 8095.757127286176, 8330.0, 8822.161894620009, 8882.200601945831, 8376.664933402672, 8636.956815215915, 8655.221030107288, 8864.64541418344, 8879.067697891709, 2461.581531139706, 2491.9003239870385, 2494.5135698538793, 2503.0113105323385, 2510.083819405922, 2435.8173137014705, 2505.912293069743, 2512.5477414065463, 2524.2427271818474, 2526.6967963844363, 2446.3150317911013, 2469.1851688942606, 2476.8142389320783, 2498.525280196766, 2503.674522312097, 2394.7605239476175, 2414.915477958272, 2428.2715185444295, 2445.5353482838204, 2453.3130723397476, 2443.4746529496065, 2445.2786428003783, 2460.692413448319, 2463.938401539958, 2464.9876750616313, 8721.738347849574, 8750.824983500357, 8795.692150774692, 8844.380893337404, 8908.0, 5404.270423492818, 5466.945330546683, 5542.5565954723525, 5544.833654990357, 5549.306336707911, 3354.66453354665, 3366.461366181399, 3384.3738908302043, 3440.8451619677176, 3473.027552285364, 1103.0734183285997, 1121.6915348279288, 1126.2622981946838, 1141.7602303516271, 2173.71741673583, 11725.472353744102, 12097.516099356015, 12109.0, 12165.391730413532, 12166.51333946641, 4611.2852507861335, 4643.558861908114, 4738.289256611467, 4740.905181896343, 4761.142994261067, 9784.55969481375, 9799.510024498746, 9828.31201815866, 9829.852552211723, 9887.950560247153, 5276.445973172838, 5279.287296215039, 5337.492938170868, 5337.519623233928, 5355.598330125256, 4455.064436468313, 4772.0, 4975.10448119342, 4993.1262029144755, 5045.621578381636, 3900.4539364488996, 3910.452536644872, 3954.387070004154, 4021.4369988201674, 4027.134166154291, 1208.9516419343304, 1215.0826126274783, 1225.3689349984766, 1227.4227617511456, 1253.2918900821007, 872.3239489395769, 958.9616415343447, 976.3848775271675, 986.9309148359689, 1006.9125344627785, 5659.8019069333195, 5941.7623295067715, 6119.357467465852, 6295.150154729145, 6353.714082866282, 937.7421209167397, 956.1203692602822, 957.7366224288377, 974.5176137811828, 978.848278516831, 3914.451976723261, 3978.124812541236, 4060.7869958962833, 4119.732217405859, 4262.168877068942, 10571.15430765537, 10949.343039417661, 11011.504482298316, 11053.392063436428, 11057.281276716987, 10936.289141205796, 10944.069754070833, 10948.39783811882, 11007.119430445546, 11045.613403530999, 7866.528008319405, 8242.835143297101, 8247.257746802816, 8325.750227493185, 8441.577921104043, 5783.8554036149435, 5964.850878728066, 5973.581849270683, 6173.351798061319, 6185.474234690102, 9879.259055570717, 9912.454814984956, 9959.950200249243, 9967.850482242917, 10078.647247346307, 10039.447830369108, 10054.0, 10119.544620491948, 10137.138343240907, 10231.693049208536, 8009.118996910452, 8040.83918321642, 8209.425340226127, 8228.588570571566, 8240.093589705008, 8494.1081186477, 8517.74446766598, 8568.657253709782, 8574.27118694893, 8581.0, 7460.813479663052, 7527.736529221451, 7574.128975167926, 7575.810604734926, 7599.810004749926, 7373.0, 7517.774466766005, 7552.9244707552225, 7564.352476633135, 7635.274648908345, 6697.497687673346, 6845.212800528003, 6992.650367481504, 6994.055802466602, 7003.6498175092065, 5039.0, 5056.84829455117, 5166.328377310925, 5233.267342571967, 5238.5023422774775, 5167.431582525995, 5171.431142574389, 5244.0, 5271.920921186262, 5379.596530260168], "value": 4713.301264503572, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.81272113058947, 355.0537816718444, 355.804307630803, 361.4542041517309, 363.62364952274385, 5488.862778430541, 5651.039323315031, 5725.942740572593, 5725.942740572598, 5732.340780810208, 5576.442355764431, 5592.5805564582615, 5622.718864056801, 5660.792291006501, 5666.036773748462, 4429.247028005247, 4457.509673935864, 4467.798949047301, 4476.529964353745, 4479.708818926776, 4301.720388174758, 4363.367311739796, 4406.272964960777, 4431.894849946282, 4475.261581838992, 4344.261475549164, 4353.912921741563, 4356.869293921188, 4357.956420435803, 4380.496242932056, 4399.252127138394, 4403.405540252073, 4417.271150260203, 4425.291953287458, 4456.46522417312, 3707.703383729295, 3928.4303775952612, 3939.4484772131923, 3941.1526521797664, 3959.0, 5495.0658388073725, 5497.422770609069, 5512.80705175317, 5518.089515229983, 5519.806806761784, 5076.873078173038, 5096.898062038776, 5103.897922041539, 5109.054824857376, 5113.309703190059, 5758.539316854642, 5835.299764028344, 5860.09168578871, 5863.618864773776, 5901.675407852566, 4215.662746980234, 4227.154569086195, 4235.788210589458, 4241.597048280409, 4244.808983595745, 6180.165677633552, 6213.782517611907, 6223.626582405025, 6224.128621992924, 6229.9129791519445, 4184.0, 4348.0, 4381.759003254788, 4433.7118087324225, 4434.467863856294, 4435.800388982503, 4437.511873693891, 4439.067795762926, 4443.511213766483, 4450.1989641864775, 5026.497350265017, 5030.547250747377, 5040.168372218616, 5059.620528460307, 5091.109055915274, 5745.195672605839, 5797.391273916178, 5850.168139868308, 5878.7954517056105, 5941.465268125889, 1461.0211158523814, 1461.3423959218394, 1468.0824484697064, 1473.8894582906325, 1478.2091581004327, 1008.7160904906416, 1035.7928414317166, 1037.3257382701304, 1042.4058286776617, 1054.3568423261804, 5526.281583394213, 5544.336698990287, 5545.584081193927, 5608.401605542401, 5649.830505084854, 5850.765969361178, 5857.648541087548, 5860.150278209721, 5889.705514724246, 5960.066356204884, 5416.864578385493, 5518.724063796874, 5558.194061861008, 5561.916571251353, 5571.637843540238, 3145.7102587938834, 3157.36852629475, 3165.572647692578, 3168.8732450702173, 3176.857041433141, 5858.677772722541, 6128.3565225651555, 6151.538634602333, 6218.471429928507, 6224.657643829542, 5978.3124940631515, 5997.790077347272, 6002.519798416116, 6009.188759517497, 6015.39846015395, 6119.368671471221, 6121.816345509642, 6144.324124346318, 6147.784827531015, 6263.624182548971, 5805.941940580709, 5815.749613832877, 5824.835242801418, 5860.619059761102, 5888.528917686489, 5756.280464941882, 5800.010986761027, 5817.912731308949, 5824.679642619697, 5873.530117590668, 5856.809152075443, 6065.211522502046, 6100.444386681545, 6148.04893651041, 6191.628502289877, 4275.828966841416, 4283.922297685683, 4288.442502474658, 4290.957090429056, 4321.330193819963, 5884.735186916513, 5979.133025711334, 5982.1325907744, 6015.819525414245, 6125.264968203844, 6001.0, 6012.338642749207, 6021.367756385516, 6044.486218671286, 6050.9394906050375, 5936.495397891227, 5974.0, 6005.249343832021, 6007.729652165575, 6013.518918486423, 5645.520130788765, 5896.729759042713, 5922.437368449991, 5923.6757167269, 5923.970380148072, 5984.222051133324, 6011.527175841947, 6030.758769649165, 6045.75816967334, 6144.4777193937225, 5524.58565607573, 5796.159556864315, 5883.294004719461, 5913.940860591339, 5959.344472108151], "value": 4497.527719897472, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.2530307041422, 771.0015529888793, 846.3060290561738, 862.1938487514171, 881.3874357321662, 15180.468683596077, 16003.599910002256, 16019.0, 16060.67878642428, 16136.919315403422, 14542.636434089152, 14759.852401475982, 14819.555413337617, 14846.406143754237, 14860.479883204063, 844.1178967978462, 851.3359579527978, 860.6772460327377, 862.7799911022712, 865.0138841720412, 859.5659192108008, 863.6329559937002, 865.1002956924791, 865.2169786343338, 865.7878819689184, 884.1953822021961, 891.692366133686, 893.2496702769672, 897.7979954510248, 897.905719899411, 886.0740526150156, 887.6981826179098, 892.0989800301677, 892.4823602310644, 893.1916615463016, 653.598037207119, 656.1568384625781, 656.1994366872408, 658.8451713847242, 659.2484567592948, 13248.933755331162, 13264.734705305937, 13279.601611951657, 13280.402381892742, 13286.800697989442, 12752.80870786939, 12849.100562960597, 13012.763787440274, 13215.074944753775, 13216.73566528664, 11075.889241107647, 11086.61196858106, 11122.55509779608, 11126.833097503544, 11148.275362101438, 3749.5500539935383, 3791.5071040764524, 3851.229754049173, 3860.8455661773496, 3941.093548483836, 63638.0, 63789.681051594445, 64339.67830160866, 65067.99999999953, 65980.0, 9696.224302055818, 9949.80100397988, 9958.053984871425, 10210.591576337012, 10260.743481413025, 19344.903275483815, 19388.70916936247, 19400.126994285292, 19416.611667766847, 19428.708569371473, 7908.719448006125, 8419.621117049624, 8515.744527664056, 8598.87101693475, 8680.262177714838, 4441.733495990251, 4520.61574766142, 4605.286180642006, 4752.334673145762, 4997.700137991732, 3448.9827550862087, 3657.579378371521, 3665.596784353719, 3678.3378991781738, 3695.815209239527, 672.3814091036259, 673.2224280955504, 682.4676752133344, 683.6513378177066, 686.584616307127, 723.2947875821033, 755.6221889055472, 764.533634482965, 793.2860425616991, 799.0890384961149, 9514.191293739972, 9601.183899368492, 9730.270229732798, 9788.55951482185, 10241.94879025615, 677.11298199359, 743.4981387563481, 747.6261869065468, 766.1266156581502, 786.2059320086754, 4806.951930480651, 5003.149464591028, 5020.196768517093, 5042.117629414838, 5055.317532133115, 59037.0, 60978.69510652418, 93899.53050234706, 96158.76313371368, 97632.0, 80008.0, 80243.59878200572, 80542.19457805347, 81341.59329203435, 82558.58720706358, 70559.2944070563, 71994.64002679953, 73797.26202738011, 75679.62160189274, 76180.61909690527, 9542.952285238529, 9551.61793528279, 9584.808303834025, 9655.0, 9989.850152247576, 47575.0, 48177.5182248173, 48554.51445485641, 48937.75531122321, 50353.244701330244, 53860.46139538711, 54338.18492722692, 61448.38551614427, 66538.66730666316, 68258.0, 12425.75148497007, 12469.189502682659, 12571.685707857378, 13064.477420903437, 13072.607821765363, 14033.859661403256, 15005.924970375077, 15216.163111029, 15231.847681523486, 15676.05943643385, 14168.574942751733, 14405.855941440452, 14619.488317908823, 14721.484748033767, 14822.851771482146, 13232.603021909357, 13291.202527847974, 13837.861621383658, 13945.860541394863, 14846.925765371105, 12198.390080495763, 13068.934655326662, 13203.603891882874, 14017.649558760704, 14302.356393962089, 10694.679159625224, 10706.357618542912, 10931.617393391192, 11161.49773260189, 11565.248258863483, 11695.88304116948, 11906.821397679216, 12005.39973001329, 12082.154249202471, 12388.380580971096], "value": 7379.193168767953, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1486.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 112.0, 111.0, 110.0, 110.0, 111.0, 110.0, 112.0, 110.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 125.0, 123.0, 171.0, 123.0, 127.0, 132.0, 129.0, 150.0, 127.0], "value": 136.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 173.0, 166.0, 163.0, 163.0, 162.0, 163.0, 162.0, 162.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 113.0, 75.0, 76.0, 75.0, 75.0, 109.0, 75.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 110.0, 84.0, 82.0, 81.0, 97.0, 82.0, 82.0, 113.0], "value": 89.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 120.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 150.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 148.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 87.0, 86.0, 85.0, 85.0, 86.0, 86.0, 85.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 51.0, 51.0, 50.0, 52.0, 53.0, 52.0, 52.0, 55.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 60.0, 60.0, 59.0, 59.0, 60.0, 60.0, 60.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 79.0, 76.0, 76.0, 84.0, 84.0, 77.0, 76.0, 76.0, 83.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 130.0, 130.0, 140.0, 128.0, 139.0, 146.0, 132.0, 169.0, 135.0], "value": 137.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 157.0, 162.0, 158.0, 158.0, 159.0, 157.0, 163.0, 158.0, 158.0], "value": 159.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 68.0, 64.0, 68.0, 67.0, 63.0, 69.0, 62.0, 64.0], "value": 65.4, "unit": "score"}]}]} 09:08:25 INFO - Return code: 0 09:08:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:08:25 ERROR - # TBPL SUCCESS # 09:08:25 INFO - Running post-action listener: _resource_record_post_action 09:08:25 INFO - [mozharness: 2016-12-05 17:08:25.447724Z] Finished run-tests step (success) 09:08:25 INFO - Running post-run listener: _resource_record_post_run 09:08:25 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 354373632; Read time: 8; Write time: 208920 09:08:25 INFO - TinderboxPrint: CPU usage
13.3% 09:08:25 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 09:08:25 INFO - TinderboxPrint: I/O write bytes / time
354,373,632 / 208,920 09:08:25 INFO - TinderboxPrint: CPU idle
8,233.7 (86.6%) 09:08:25 INFO - TinderboxPrint: CPU user
1,210.2 (12.7%) 09:08:25 INFO - TinderboxPrint: Swap in / out
0 / 0 09:08:25 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108216320; Read time: 0; Write time: 83024 09:08:25 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 246157312; Read time: 0; Write time: 125896 09:08:26 INFO - Running post-run listener: _upload_blobber_files 09:08:26 INFO - Blob upload gear active. 09:08:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:08:26 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:08:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:08:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:08:26 INFO - (blobuploader) - INFO - Open directory for files ... 09:08:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:08:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:08:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:08:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:08:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:08:27 INFO - (blobuploader) - INFO - Done attempting. 09:08:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:08:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:08:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:08:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:08:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:08:28 INFO - (blobuploader) - INFO - Done attempting. 09:08:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:08:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:08:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:08:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:08:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:08:31 INFO - (blobuploader) - INFO - Done attempting. 09:08:31 INFO - (blobuploader) - INFO - Iteration through files over. 09:08:31 INFO - Return code: 0 09:08:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:08:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:08:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/10bf82affd5d8b19f4a51ac1b2e66af629106cf6a399e1eae6d5b14a4a2186719ae8daf42eefe3510197b77a15e7ef7e6d4cab023487b7afa1a97c31c92b131f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ffe31284095aa98f7e805c07470846d64ac3d13dd144e45fd2e0f5055e09dc060cbb43c8a9c163605e45adc47b8b90a3a10615c41545ccf19b3edfa377fa575a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5fc1a859b951a074a76d94d021c1a4a8b67eac718957fafc6ecfb560467b326f15d1c33207198855a6c52310868ff613e5b3cda0f2786bdf081c46c2c17d84af"} 09:08:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:08:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:08:31 INFO - Contents: 09:08:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/10bf82affd5d8b19f4a51ac1b2e66af629106cf6a399e1eae6d5b14a4a2186719ae8daf42eefe3510197b77a15e7ef7e6d4cab023487b7afa1a97c31c92b131f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ffe31284095aa98f7e805c07470846d64ac3d13dd144e45fd2e0f5055e09dc060cbb43c8a9c163605e45adc47b8b90a3a10615c41545ccf19b3edfa377fa575a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5fc1a859b951a074a76d94d021c1a4a8b67eac718957fafc6ecfb560467b326f15d1c33207198855a6c52310868ff613e5b3cda0f2786bdf081c46c2c17d84af"} 09:08:31 INFO - Running post-run listener: copy_logs_to_upload_dir 09:08:31 INFO - Copying logs to upload dir... 09:08:31 INFO - mkdir: /builds/slave/test/build/upload/logs 09:08:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.650809 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-12-05 09:08:31.598341) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-05 09:08:31.602001) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/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/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1480955414.221239-1221525279 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/10bf82affd5d8b19f4a51ac1b2e66af629106cf6a399e1eae6d5b14a4a2186719ae8daf42eefe3510197b77a15e7ef7e6d4cab023487b7afa1a97c31c92b131f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ffe31284095aa98f7e805c07470846d64ac3d13dd144e45fd2e0f5055e09dc060cbb43c8a9c163605e45adc47b8b90a3a10615c41545ccf19b3edfa377fa575a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5fc1a859b951a074a76d94d021c1a4a8b67eac718957fafc6ecfb560467b326f15d1c33207198855a6c52310868ff613e5b3cda0f2786bdf081c46c2c17d84af"} build_url:https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011730 build_url: 'https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.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/10bf82affd5d8b19f4a51ac1b2e66af629106cf6a399e1eae6d5b14a4a2186719ae8daf42eefe3510197b77a15e7ef7e6d4cab023487b7afa1a97c31c92b131f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ffe31284095aa98f7e805c07470846d64ac3d13dd144e45fd2e0f5055e09dc060cbb43c8a9c163605e45adc47b8b90a3a10615c41545ccf19b3edfa377fa575a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5fc1a859b951a074a76d94d021c1a4a8b67eac718957fafc6ecfb560467b326f15d1c33207198855a6c52310868ff613e5b3cda0f2786bdf081c46c2c17d84af"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-05 09:08:31.628199) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 09:08:31.628582) ========= rm -f oauth.txt in dir /builds/slave/test/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1480955414.221239-1221525279 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 09:08:31.712796) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-05 09:08:31.713143) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-05 09:08:31.713451) ========= ========= Total master_lag: 0.19 =========